builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1452872391.45 results: success (0) buildid: 20160115065941 builduid: 7a197c3a8658457eb00045a0512a7c7b revision: f427e163a30417600d5f9547ac8abc2b7847cc69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.453893) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.454856) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.455195) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006487 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.501587) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.502189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.539316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.539752) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.595017) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.595347) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.595723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.596019) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 07:39:51-- 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% 219M=0s 2016-01-15 07:39:51 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.313613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.926842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.927247) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018603 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.978317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:51.978675) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f427e163a30417600d5f9547ac8abc2b7847cc69 --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 f427e163a30417600d5f9547ac8abc2b7847cc69 --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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 07:39:52,113 truncating revision to first 12 chars 2016-01-15 07:39:52,113 Setting DEBUG logging. 2016-01-15 07:39:52,114 attempt 1/10 2016-01-15 07:39:52,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f427e163a304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 07:39:52,649 unpacking tar archive at: fx-team-f427e163a304/testing/mozharness/ program finished with exit code 0 elapsedTime=0.852151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:52.845164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:52.845491) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:52.855116) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:52.855887) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 07:39:52.856500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-01-15 07:39:52.856848) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:39:53 INFO - MultiFileLogger online at 20160115 07:39:53 in /builds/slave/test 07:39:53 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 07:39:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:39:53 INFO - {'append_to_log': False, 07:39:53 INFO - 'base_work_dir': '/builds/slave/test', 07:39:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:39:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:39:53 INFO - 'branch': 'Fx-Team-Non-PGO', 07:39:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:39:53 INFO - 'config_files': ('talos/linux_config.py',), 07:39:53 INFO - 'default_actions': ('clobber', 07:39:53 INFO - 'read-buildbot-config', 07:39:53 INFO - 'download-and-extract', 07:39:53 INFO - 'populate-webroot', 07:39:53 INFO - 'create-virtualenv', 07:39:53 INFO - 'install', 07:39:53 INFO - 'run-tests'), 07:39:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:39:53 INFO - 'download_minidump_stackwalk': True, 07:39:53 INFO - 'download_symbols': 'ondemand', 07:39:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:39:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:39:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:39:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:39:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:39:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:39:53 INFO - 'installer_path': 'installer.exe', 07:39:53 INFO - 'log_level': 'info', 07:39:53 INFO - 'log_name': 'talos', 07:39:53 INFO - 'log_to_console': True, 07:39:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:39:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:39:53 INFO - 'opt_config_files': (), 07:39:53 INFO - 'pip_index': False, 07:39:53 INFO - 'sps_profile': False, 07:39:53 INFO - 'sps_profile_interval': 0, 07:39:53 INFO - 'suite': 'dromaeojs-e10s', 07:39:53 INFO - 'system_bits': '32', 07:39:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:39:53 INFO - 'title': 'talos-linux64-ix-012', 07:39:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:39:53 INFO - 'use_talos_json': True, 07:39:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:39:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:39:53 INFO - 'work_dir': 'build'} 07:39:53 INFO - ##### 07:39:53 INFO - ##### Running clobber step. 07:39:53 INFO - ##### 07:39:53 INFO - Running pre-action listener: _resource_record_pre_action 07:39:53 INFO - Running main action method: clobber 07:39:53 INFO - rmtree: /builds/slave/test/build 07:39:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:39:54 INFO - Running post-action listener: _resource_record_post_action 07:39:54 INFO - ##### 07:39:54 INFO - ##### Running read-buildbot-config step. 07:39:54 INFO - ##### 07:39:54 INFO - Running pre-action listener: _resource_record_pre_action 07:39:54 INFO - Running main action method: read_buildbot_config 07:39:54 INFO - Using buildbot properties: 07:39:54 INFO - { 07:39:54 INFO - "project": "", 07:39:54 INFO - "product": "firefox", 07:39:54 INFO - "script_repo_revision": "production", 07:39:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:39:54 INFO - "repository": "", 07:39:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:39:54 INFO - "buildid": "20160115065941", 07:39:54 INFO - "pgo_build": "False", 07:39:54 INFO - "basedir": "/builds/slave/test", 07:39:54 INFO - "buildnumber": 962, 07:39:54 INFO - "slavename": "talos-linux64-ix-012", 07:39:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:39:54 INFO - "platform": "ubuntu64_hw", 07:39:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:39:54 INFO - "branch": "fx-team", 07:39:54 INFO - "repo_path": "integration/fx-team", 07:39:54 INFO - "revision": "f427e163a30417600d5f9547ac8abc2b7847cc69", 07:39:54 INFO - "stage_platform": "linux64", 07:39:54 INFO - "builduid": "7a197c3a8658457eb00045a0512a7c7b", 07:39:54 INFO - "slavebuilddir": "test" 07:39:54 INFO - } 07:39:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:39:54 INFO - Running post-action listener: _resource_record_post_action 07:39:54 INFO - ##### 07:39:54 INFO - ##### Running download-and-extract step. 07:39:54 INFO - ##### 07:39:54 INFO - Running pre-action listener: _resource_record_pre_action 07:39:54 INFO - Running main action method: download_and_extract 07:39:54 INFO - mkdir: /builds/slave/test/build/tests 07:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:54 INFO - https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:39:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/test_packages.json 07:39:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/test_packages.json 07:39:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:40:00 INFO - Downloaded 1448 bytes. 07:40:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:40:00 INFO - Using the following test package requirements: 07:40:00 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:40:00 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:40:00 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:40:00 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'jsshell-linux-x86_64.zip'], 07:40:00 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:40:00 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:40:00 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:40:00 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:40:00 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:40:00 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:40:00 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:00 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:40:00 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:00 INFO - https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:40:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:40:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:40:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:07 INFO - Downloaded 21172667 bytes. 07:40:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:40:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:40:08 INFO - Return code: 0 07:40:08 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 07:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:08 INFO - https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:40:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:40:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:40:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:13 INFO - Downloaded 21172667 bytes. 07:40:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:40:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:40:15 INFO - Return code: 0 07:40: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')]} 07:40:15 INFO - https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:40:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:40:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:40:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:21 INFO - Downloaded 11132144 bytes. 07:40:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:40:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:40:21 INFO - Return code: 0 07:40: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')]} 07:40:21 INFO - https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:40:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:40:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:40:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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 07:40:31 INFO - Downloaded 54119992 bytes. 07:40:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:40:31 INFO - mkdir: /builds/slave/test/properties 07:40:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:40:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:40:31 INFO - Contents: 07:40:31 INFO - build_url:https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:40:31 INFO - Running post-action listener: _resource_record_post_action 07:40:31 INFO - Running post-action listener: set_extra_try_arguments 07:40:31 INFO - ##### 07:40:31 INFO - ##### Running populate-webroot step. 07:40:31 INFO - ##### 07:40:31 INFO - Running pre-action listener: _resource_record_pre_action 07:40:31 INFO - Running main action method: populate_webroot 07:40:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:40:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:40:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:40:31 INFO - '--tppagecycles', 07:40:31 INFO - '7'], 07:40:31 INFO - 'tests': ['tsvgm']}}, 07:40:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:40:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:40:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:40:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:40:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'tests': ['damp', 'tps']}, 07:40:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['damp', 'tps']}, 07:40:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:40:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:40:31 INFO - 'other': {'tests': ['a11yr', 07:40:31 INFO - 'ts_paint', 07:40:31 INFO - 'tpaint', 07:40:31 INFO - 'sessionrestore', 07:40:31 INFO - 'sessionrestore_no_auto_restore']}, 07:40:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['a11yr', 07:40:31 INFO - 'ts_paint', 07:40:31 INFO - 'tpaint', 07:40:31 INFO - 'sessionrestore', 07:40:31 INFO - 'sessionrestore_no_auto_restore']}, 07:40:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['a11yr', 07:40:31 INFO - 'ts_paint', 07:40:31 INFO - 'tpaint', 07:40:31 INFO - 'sessionrestore', 07:40:31 INFO - 'sessionrestore_no_auto_restore']}, 07:40:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['a11yr', 07:40:31 INFO - 'ts_paint', 07:40:31 INFO - 'tpaint', 07:40:31 INFO - 'sessionrestore', 07:40:31 INFO - 'sessionrestore_no_auto_restore']}, 07:40:31 INFO - 'other_l64': {'tests': ['a11yr', 07:40:31 INFO - 'ts_paint', 07:40:31 INFO - 'tpaint', 07:40:31 INFO - 'sessionrestore', 07:40:31 INFO - 'sessionrestore_no_auto_restore']}, 07:40:31 INFO - 'other_nol64': {'tests': ['a11yr', 07:40:31 INFO - 'ts_paint', 07:40:31 INFO - 'tpaint', 07:40:31 INFO - 'sessionrestore', 07:40:31 INFO - 'sessionrestore_no_auto_restore']}, 07:40:31 INFO - 'svgr': {'tests': ['tsvgx', 07:40:31 INFO - 'tsvgr_opacity', 07:40:31 INFO - 'tart', 07:40:31 INFO - 'tscrollx', 07:40:31 INFO - 'cart']}, 07:40:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['tsvgx', 07:40:31 INFO - 'tsvgr_opacity', 07:40:31 INFO - 'tart', 07:40:31 INFO - 'tscrollx', 07:40:31 INFO - 'cart']}, 07:40:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'tests': ['tp5o']}, 07:40:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'talos_options': ['--e10s'], 07:40:31 INFO - 'tests': ['tp5o']}, 07:40:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'talos_options': ['--xperf_path', 07:40:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:31 INFO - 'tests': ['tp5n']}, 07:40:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:31 INFO - 'talos_options': ['--e10s', 07:40:31 INFO - '--xperf_path', 07:40:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:31 INFO - 'tests': ['tp5n']}}, 07:40:31 INFO - 'talos.zip': {'path': '', 07:40:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:40:31 INFO - Running post-action listener: _resource_record_post_action 07:40:31 INFO - ##### 07:40:31 INFO - ##### Running create-virtualenv step. 07:40:31 INFO - ##### 07:40:31 INFO - Running pre-action listener: _resource_record_pre_action 07:40:31 INFO - Running main action method: create_virtualenv 07:40:31 INFO - Creating virtualenv /builds/slave/test/build/venv 07:40:31 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 07:40:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:40:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:40:31 INFO - Using real prefix '/usr' 07:40:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:40:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:40:33 INFO - Installing pip.................done. 07:40:33 INFO - Return code: 0 07:40:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:40:33 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')]} 07:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:33 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')]} 07:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:33 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:33 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 07:40:33 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 07:40:33 INFO - Using env: {'DISPLAY': ':0', 07:40:33 INFO - 'HOME': '/home/cltbld', 07:40:33 INFO - 'LANG': 'en_US.UTF-8', 07:40:33 INFO - 'LANGUAGE': 'en_US:en', 07:40:33 INFO - 'LOGNAME': 'cltbld', 07:40:33 INFO - 'MAIL': '/var/mail/cltbld', 07:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:33 INFO - 'MOZ_NO_REMOTE': '1', 07:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:33 INFO - 'NO_EM_RESTART': '1', 07:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:33 INFO - 'PWD': '/builds/slave/test', 07:40:33 INFO - 'SHELL': '/bin/bash', 07:40:33 INFO - 'SHLVL': '1', 07:40:33 INFO - 'TERM': 'linux', 07:40:33 INFO - 'TMOUT': '86400', 07:40:33 INFO - 'USER': 'cltbld', 07:40:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:33 INFO - '_': '/tools/buildbot/bin/python'} 07:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:34 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 07:40:34 INFO - Cleaning up... 07:40:34 INFO - Return code: 0 07:40:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:40: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')]} 07:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40: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')]} 07:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40: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', '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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40: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', 'psutil>=0.7.1'] in /builds/slave/test/build 07:40: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 psutil>=0.7.1 07:40:34 INFO - Using env: {'DISPLAY': ':0', 07:40:34 INFO - 'HOME': '/home/cltbld', 07:40:34 INFO - 'LANG': 'en_US.UTF-8', 07:40:34 INFO - 'LANGUAGE': 'en_US:en', 07:40:34 INFO - 'LOGNAME': 'cltbld', 07:40:34 INFO - 'MAIL': '/var/mail/cltbld', 07:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:34 INFO - 'MOZ_NO_REMOTE': '1', 07:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:34 INFO - 'NO_EM_RESTART': '1', 07:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:34 INFO - 'PWD': '/builds/slave/test', 07:40:34 INFO - 'SHELL': '/bin/bash', 07:40:34 INFO - 'SHLVL': '1', 07:40:34 INFO - 'TERM': 'linux', 07:40:34 INFO - 'TMOUT': '86400', 07:40:34 INFO - 'USER': 'cltbld', 07:40:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:34 INFO - '_': '/tools/buildbot/bin/python'} 07:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:34 INFO - Downloading/unpacking psutil>=0.7.1 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40:36 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:40:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:40:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:36 INFO - Installing collected packages: psutil 07:40:36 INFO - Running setup.py install for psutil 07:40:36 INFO - building 'psutil._psutil_linux' extension 07:40:36 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 07:40:36 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 07:40:36 INFO - building 'psutil._psutil_posix' extension 07:40:36 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 07:40:36 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 07:40:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:36 INFO - Successfully installed psutil 07:40:36 INFO - Cleaning up... 07:40:36 INFO - Return code: 0 07:40:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:36 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:36 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 07:40:36 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 07:40:36 INFO - Using env: {'DISPLAY': ':0', 07:40:36 INFO - 'HOME': '/home/cltbld', 07:40:36 INFO - 'LANG': 'en_US.UTF-8', 07:40:36 INFO - 'LANGUAGE': 'en_US:en', 07:40:36 INFO - 'LOGNAME': 'cltbld', 07:40:36 INFO - 'MAIL': '/var/mail/cltbld', 07:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:36 INFO - 'MOZ_NO_REMOTE': '1', 07:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:36 INFO - 'NO_EM_RESTART': '1', 07:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:36 INFO - 'PWD': '/builds/slave/test', 07:40:36 INFO - 'SHELL': '/bin/bash', 07:40:36 INFO - 'SHLVL': '1', 07:40:36 INFO - 'TERM': 'linux', 07:40:36 INFO - 'TMOUT': '86400', 07:40:36 INFO - 'USER': 'cltbld', 07:40:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:36 INFO - '_': '/tools/buildbot/bin/python'} 07:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:40:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:40:38 INFO - Installing collected packages: mozsystemmonitor 07:40:38 INFO - Running setup.py install for mozsystemmonitor 07:40:38 INFO - Successfully installed mozsystemmonitor 07:40:38 INFO - Cleaning up... 07:40:38 INFO - Return code: 0 07:40:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:38 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:38 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 07:40:38 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 07:40:38 INFO - Using env: {'DISPLAY': ':0', 07:40:38 INFO - 'HOME': '/home/cltbld', 07:40:38 INFO - 'LANG': 'en_US.UTF-8', 07:40:38 INFO - 'LANGUAGE': 'en_US:en', 07:40:38 INFO - 'LOGNAME': 'cltbld', 07:40:38 INFO - 'MAIL': '/var/mail/cltbld', 07:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:38 INFO - 'MOZ_NO_REMOTE': '1', 07:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:38 INFO - 'NO_EM_RESTART': '1', 07:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:38 INFO - 'PWD': '/builds/slave/test', 07:40:38 INFO - 'SHELL': '/bin/bash', 07:40:38 INFO - 'SHLVL': '1', 07:40:38 INFO - 'TERM': 'linux', 07:40:38 INFO - 'TMOUT': '86400', 07:40:38 INFO - 'USER': 'cltbld', 07:40:38 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:38 INFO - '_': '/tools/buildbot/bin/python'} 07:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:40:39 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 07:40:39 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 07:40:39 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 07:40:39 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 07:40:39 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 07:40:39 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 07:40:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:40:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:40:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:40:40 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 07:40:40 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 07:40:40 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 07:40:40 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 07:40:40 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 07:40:40 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 07:40:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:40:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:40:41 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 07:40:41 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 07:40:41 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 07:40:41 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 07:40:41 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 07:40:41 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 07:40:41 INFO - Downloading docopt-0.6.1.tar.gz 07:40:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:40:41 INFO - Installing collected packages: blobuploader, requests, docopt 07:40:41 INFO - Running setup.py install for blobuploader 07:40:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:40:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:40:41 INFO - Running setup.py install for requests 07:40:42 INFO - Running setup.py install for docopt 07:40:42 INFO - Successfully installed blobuploader requests docopt 07:40:42 INFO - Cleaning up... 07:40:42 INFO - Return code: 0 07:40:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:42 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:42 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 07:40:42 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 07:40:42 INFO - Using env: {'DISPLAY': ':0', 07:40:42 INFO - 'HOME': '/home/cltbld', 07:40:42 INFO - 'LANG': 'en_US.UTF-8', 07:40:42 INFO - 'LANGUAGE': 'en_US:en', 07:40:42 INFO - 'LOGNAME': 'cltbld', 07:40:42 INFO - 'MAIL': '/var/mail/cltbld', 07:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:42 INFO - 'MOZ_NO_REMOTE': '1', 07:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:42 INFO - 'NO_EM_RESTART': '1', 07:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:42 INFO - 'PWD': '/builds/slave/test', 07:40:42 INFO - 'SHELL': '/bin/bash', 07:40:42 INFO - 'SHLVL': '1', 07:40:42 INFO - 'TERM': 'linux', 07:40:42 INFO - 'TMOUT': '86400', 07:40:42 INFO - 'USER': 'cltbld', 07:40:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:42 INFO - '_': '/tools/buildbot/bin/python'} 07:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:40:42 INFO - Running setup.py (path:/tmp/pip-XDUn3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:40:42 INFO - Running setup.py (path:/tmp/pip-PErUSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:40:42 INFO - Running setup.py (path:/tmp/pip-TfWzTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:40:42 INFO - Running setup.py (path:/tmp/pip-OpGKul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:40:42 INFO - Running setup.py (path:/tmp/pip-fsbZMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:40:42 INFO - Running setup.py (path:/tmp/pip-Y91NMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:40:42 INFO - Running setup.py (path:/tmp/pip-41VxHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:40:42 INFO - Running setup.py (path:/tmp/pip-TDjYwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:40:42 INFO - Running setup.py (path:/tmp/pip-aktAJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:40:43 INFO - Running setup.py (path:/tmp/pip-dZd77q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:40:43 INFO - Running setup.py (path:/tmp/pip-mWD1r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:40:43 INFO - Running setup.py (path:/tmp/pip-zeguBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:40:43 INFO - Running setup.py (path:/tmp/pip-lXl8Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:40:43 INFO - Running setup.py (path:/tmp/pip-NMNNgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:43 INFO - Running setup.py (path:/tmp/pip-qHVVdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:40:43 INFO - Running setup.py (path:/tmp/pip-YT2zYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:40:43 INFO - Running setup.py (path:/tmp/pip-1zDr0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:40:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:40:43 INFO - Running setup.py install for manifestparser 07:40:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:40:43 INFO - Running setup.py install for mozcrash 07:40:43 INFO - Running setup.py install for mozdebug 07:40:43 INFO - Running setup.py install for mozdevice 07:40:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozfile 07:40:44 INFO - Running setup.py install for mozhttpd 07:40:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozinfo 07:40:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozInstall 07:40:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozleak 07:40:44 INFO - Running setup.py install for mozlog 07:40:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for moznetwork 07:40:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozprocess 07:40:44 INFO - Running setup.py install for mozprofile 07:40:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozrunner 07:40:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:40:45 INFO - Running setup.py install for mozscreenshot 07:40:45 INFO - Running setup.py install for moztest 07:40:45 INFO - Running setup.py install for mozversion 07:40:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:40:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:40:45 INFO - Cleaning up... 07:40:45 INFO - Return code: 0 07:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:45 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:45 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 07:40:45 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 07:40:45 INFO - Using env: {'DISPLAY': ':0', 07:40:45 INFO - 'HOME': '/home/cltbld', 07:40:45 INFO - 'LANG': 'en_US.UTF-8', 07:40:45 INFO - 'LANGUAGE': 'en_US:en', 07:40:45 INFO - 'LOGNAME': 'cltbld', 07:40:45 INFO - 'MAIL': '/var/mail/cltbld', 07:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:45 INFO - 'MOZ_NO_REMOTE': '1', 07:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:45 INFO - 'NO_EM_RESTART': '1', 07:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:45 INFO - 'PWD': '/builds/slave/test', 07:40:45 INFO - 'SHELL': '/bin/bash', 07:40:45 INFO - 'SHLVL': '1', 07:40:45 INFO - 'TERM': 'linux', 07:40:45 INFO - 'TMOUT': '86400', 07:40:45 INFO - 'USER': 'cltbld', 07:40:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:45 INFO - '_': '/tools/buildbot/bin/python'} 07:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:40:45 INFO - Running setup.py (path:/tmp/pip-ag_deC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:40:45 INFO - Running setup.py (path:/tmp/pip-Qp6C1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:40:45 INFO - Running setup.py (path:/tmp/pip-Zr43TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:40:45 INFO - Running setup.py (path:/tmp/pip-pxOZ5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:40:45 INFO - Running setup.py (path:/tmp/pip-OD6DO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:40:45 INFO - Running setup.py (path:/tmp/pip-HW69hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:40:46 INFO - Running setup.py (path:/tmp/pip-XCwT5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:40:46 INFO - Running setup.py (path:/tmp/pip-QlLbd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:40:46 INFO - Running setup.py (path:/tmp/pip-RTfhff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:40:46 INFO - Running setup.py (path:/tmp/pip-lSusZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:40:46 INFO - Running setup.py (path:/tmp/pip-MlpIuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:40:46 INFO - Running setup.py (path:/tmp/pip-tBfSeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:40:46 INFO - Running setup.py (path:/tmp/pip-Bs1f57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:40:46 INFO - Running setup.py (path:/tmp/pip-sRhnR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:46 INFO - Running setup.py (path:/tmp/pip-xyI2h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:40:46 INFO - Running setup.py (path:/tmp/pip-TrSndq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:40:46 INFO - Running setup.py (path:/tmp/pip-1qWNkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:40:46 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)) 07:40:46 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)) 07:40:46 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)) 07:40:46 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)) 07:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:40:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40:48 INFO - Downloading blessings-1.5.1.tar.gz 07:40:48 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 07:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:40:48 INFO - Installing collected packages: blessings 07:40:48 INFO - Running setup.py install for blessings 07:40:48 INFO - Successfully installed blessings 07:40:48 INFO - Cleaning up... 07:40:48 INFO - Return code: 0 07:40:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:40:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:49 INFO - Reading from file tmpfile_stdout 07:40:49 INFO - Current package versions: 07:40:49 INFO - argparse == 1.2.1 07:40:49 INFO - blessings == 1.5.1 07:40:49 INFO - blobuploader == 1.2.4 07:40:49 INFO - docopt == 0.6.1 07:40:49 INFO - manifestparser == 1.1 07:40:49 INFO - mozInstall == 1.12 07:40:49 INFO - mozcrash == 0.16 07:40:49 INFO - mozdebug == 0.1 07:40:49 INFO - mozdevice == 0.48 07:40:49 INFO - mozfile == 1.2 07:40:49 INFO - mozhttpd == 0.7 07:40:49 INFO - mozinfo == 0.9 07:40:49 INFO - mozleak == 0.1 07:40:49 INFO - mozlog == 3.1 07:40:49 INFO - moznetwork == 0.27 07:40:49 INFO - mozprocess == 0.22 07:40:49 INFO - mozprofile == 0.28 07:40:49 INFO - mozrunner == 6.11 07:40:49 INFO - mozscreenshot == 0.1 07:40:49 INFO - mozsystemmonitor == 0.0 07:40:49 INFO - moztest == 0.7 07:40:49 INFO - mozversion == 1.4 07:40:49 INFO - psutil == 3.1.1 07:40:49 INFO - requests == 1.2.3 07:40:49 INFO - wsgiref == 0.1.2 07:40:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:49 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')]} 07:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 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')]} 07:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:49 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 07:40:49 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 07:40:49 INFO - Using env: {'DISPLAY': ':0', 07:40:49 INFO - 'HOME': '/home/cltbld', 07:40:49 INFO - 'LANG': 'en_US.UTF-8', 07:40:49 INFO - 'LANGUAGE': 'en_US:en', 07:40:49 INFO - 'LOGNAME': 'cltbld', 07:40:49 INFO - 'MAIL': '/var/mail/cltbld', 07:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:49 INFO - 'MOZ_NO_REMOTE': '1', 07:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:49 INFO - 'NO_EM_RESTART': '1', 07:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:49 INFO - 'PWD': '/builds/slave/test', 07:40:49 INFO - 'SHELL': '/bin/bash', 07:40:49 INFO - 'SHLVL': '1', 07:40:49 INFO - 'TERM': 'linux', 07:40:49 INFO - 'TMOUT': '86400', 07:40:49 INFO - 'USER': 'cltbld', 07:40:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:49 INFO - '_': '/tools/buildbot/bin/python'} 07:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 INFO - Cleaning up... 07:40:49 INFO - Return code: 0 07:40:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:40:49 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')]} 07:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 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')]} 07:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:49 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:49 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 07:40:49 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 07:40:49 INFO - Using env: {'DISPLAY': ':0', 07:40:49 INFO - 'HOME': '/home/cltbld', 07:40:49 INFO - 'LANG': 'en_US.UTF-8', 07:40:49 INFO - 'LANGUAGE': 'en_US:en', 07:40:49 INFO - 'LOGNAME': 'cltbld', 07:40:49 INFO - 'MAIL': '/var/mail/cltbld', 07:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:49 INFO - 'MOZ_NO_REMOTE': '1', 07:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:49 INFO - 'NO_EM_RESTART': '1', 07:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:49 INFO - 'PWD': '/builds/slave/test', 07:40:49 INFO - 'SHELL': '/bin/bash', 07:40:49 INFO - 'SHLVL': '1', 07:40:49 INFO - 'TERM': 'linux', 07:40:49 INFO - 'TMOUT': '86400', 07:40:49 INFO - 'USER': 'cltbld', 07:40:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:49 INFO - '_': '/tools/buildbot/bin/python'} 07:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:49 INFO - Downloading/unpacking jsonschema 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40: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 07:40:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:40:51 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 07:40:51 INFO - Downloading/unpacking functools32 (from jsonschema) 07:40:51 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 07:40:51 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 07:40:51 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 07:40:51 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 07:40:51 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 07:40:51 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 07:40:51 INFO - Downloading functools32-3.2.3-2.tar.gz 07:40:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:40:51 INFO - warning: no files found matching '*.txt' 07:40:51 INFO - no previously-included directories found matching 'build' 07:40:51 INFO - no previously-included directories found matching 'dist' 07:40:51 INFO - no previously-included directories found matching '.git*' 07:40:51 INFO - Installing collected packages: jsonschema, functools32 07:40:51 INFO - Running setup.py install for functools32 07:40:51 INFO - warning: no files found matching '*.txt' 07:40:51 INFO - no previously-included directories found matching 'build' 07:40:51 INFO - no previously-included directories found matching 'dist' 07:40:51 INFO - no previously-included directories found matching '.git*' 07:40:51 INFO - Successfully installed jsonschema functools32 07:40:51 INFO - Cleaning up... 07:40:51 INFO - Return code: 0 07:40:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:40:51 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')]} 07:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:51 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')]} 07:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:51 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 0x7f7486bd9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', '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 07:40:51 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 07:40:51 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 07:40:51 INFO - Using env: {'DISPLAY': ':0', 07:40:51 INFO - 'HOME': '/home/cltbld', 07:40:51 INFO - 'LANG': 'en_US.UTF-8', 07:40:51 INFO - 'LANGUAGE': 'en_US:en', 07:40:51 INFO - 'LOGNAME': 'cltbld', 07:40:51 INFO - 'MAIL': '/var/mail/cltbld', 07:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:51 INFO - 'MOZ_NO_REMOTE': '1', 07:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:51 INFO - 'NO_EM_RESTART': '1', 07:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:51 INFO - 'PWD': '/builds/slave/test', 07:40:51 INFO - 'SHELL': '/bin/bash', 07:40:51 INFO - 'SHLVL': '1', 07:40:51 INFO - 'TERM': 'linux', 07:40:51 INFO - 'TMOUT': '86400', 07:40:51 INFO - 'USER': 'cltbld', 07:40:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:51 INFO - '_': '/tools/buildbot/bin/python'} 07:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:51 INFO - Downloading/unpacking flake8 07:40:51 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 07:40:51 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 07:40:51 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 07:40:51 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 07:40:51 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 07:40:51 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 07:40:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:40:53 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 07:40:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:40:53 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 07:40:53 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 07:40:53 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 07:40:53 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 07:40:53 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 07:40:53 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 07:40:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:40:53 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 07:40:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:40:53 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 07:40:53 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 07:40:53 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 07:40:53 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 07:40:53 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 07:40:53 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 07:40:54 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 07:40:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:40:54 INFO - no previously-included directories found matching 'docs/_build' 07:40:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:40:54 INFO - Running setup.py install for pep8 07:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:40:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:40:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:40:54 INFO - no previously-included directories found matching 'docs/_build' 07:40:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:40:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:40:54 INFO - Cleaning up... 07:40:54 INFO - Return code: 0 07:40:54 INFO - Running post-action listener: _resource_record_post_action 07:40:54 INFO - Running post-action listener: _start_resource_monitoring 07:40:54 INFO - Starting resource monitoring. 07:40:54 INFO - ##### 07:40:54 INFO - ##### Running install step. 07:40:54 INFO - ##### 07:40:54 INFO - Running pre-action listener: _resource_record_pre_action 07:40:54 INFO - Running main action method: install 07:40:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:54 INFO - Reading from file tmpfile_stdout 07:40:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:40:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:40:54 INFO - Reading from file tmpfile_stdout 07:40:54 INFO - Output received: 07:40:54 INFO - Usage: mozinstall [options] installer 07:40:54 INFO - Options: 07:40:54 INFO - -h, --help show this help message and exit 07:40:54 INFO - -d DEST, --destination=DEST 07:40:54 INFO - Directory to install application into. [default: 07:40:54 INFO - "/builds/slave/test"] 07:40:54 INFO - --app=APP Application being installed. [default: firefox] 07:40:54 INFO - mkdir: /builds/slave/test/build/application 07:40:54 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'] 07:40:54 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 07:41:10 INFO - Reading from file tmpfile_stdout 07:41:10 INFO - Output received: 07:41:10 INFO - /builds/slave/test/build/application/firefox/firefox 07:41:10 INFO - Running post-action listener: _resource_record_post_action 07:41:10 INFO - ##### 07:41:10 INFO - ##### Running run-tests step. 07:41:10 INFO - ##### 07:41:10 INFO - Running pre-action listener: _resource_record_pre_action 07:41:10 INFO - Running main action method: run_tests 07:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:41:10 INFO - Python 2.7.3 07:41:10 INFO - Return code: 0 07:41:10 INFO - grabbing minidump binary from tooltool 07:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:10 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 0x24ad3d0>, '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 0x2418ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2419360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:41:10 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 07:41:10 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 07:41:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:41:10 INFO - Return code: 0 07:41:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:41:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:41:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:41:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:41:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:41:11 INFO - Return code: 0 07:41:11 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/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 07:41:11 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/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 07:41:11 INFO - Using env: {'DISPLAY': ':0', 07:41:11 INFO - 'HOME': '/home/cltbld', 07:41:11 INFO - 'LANG': 'en_US.UTF-8', 07:41:11 INFO - 'LANGUAGE': 'en_US:en', 07:41:11 INFO - 'LOGNAME': 'cltbld', 07:41:11 INFO - 'MAIL': '/var/mail/cltbld', 07:41:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:41:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:11 INFO - 'MOZ_NO_REMOTE': '1', 07:41:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:11 INFO - 'NO_EM_RESTART': '1', 07:41:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:11 INFO - 'PWD': '/builds/slave/test', 07:41:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:41:11 INFO - 'SHELL': '/bin/bash', 07:41:11 INFO - 'SHLVL': '1', 07:41:11 INFO - 'TERM': 'linux', 07:41:11 INFO - 'TMOUT': '86400', 07:41:11 INFO - 'USER': 'cltbld', 07:41:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349', 07:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:11 INFO - '_': '/tools/buildbot/bin/python'} 07:41:11 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/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 07:41:11 INFO - mozversion application_buildid: 20160115065941 07:41:11 INFO - mozversion application_changeset: f427e163a30417600d5f9547ac8abc2b7847cc69 07:41:11 INFO - mozversion application_display_name: Nightly 07:41:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:41:11 INFO - mozversion application_name: Firefox 07:41:11 INFO - mozversion application_remotingname: firefox 07:41:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:41:11 INFO - mozversion application_vendor: Mozilla 07:41:11 INFO - mozversion application_version: 46.0a1 07:41:11 INFO - mozversion platform_buildid: 20160115065941 07:41:11 INFO - mozversion platform_changeset: f427e163a30417600d5f9547ac8abc2b7847cc69 07:41:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:41:11 INFO - mozversion platform_version: 46.0a1 07:41:11 INFO - using testdate: 1452872471 07:41:11 INFO - actual date: 1452872471 07:41:11 INFO - starting webserver on 'localhost:49506' 07:41:11 INFO - SUITE-START | Running 3 tests 07:41:11 INFO - TEST-START | dromaeo_css 07:41:11 INFO - operating with platform_type : linux_ 07:41:11 INFO - Initialising browser for dromaeo_css test... 07:41:11 INFO - TEST-INFO | started process 12183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg32xe1/profile http://localhost:49506/getInfo.html) 07:41:15 INFO - PROCESS | 12183 | 07:41:15 INFO - PROCESS | 12183 | (process:12265): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:41:15 INFO - PROCESS | 12183 | __metrics Screen width/height:1600/1200 07:41:15 INFO - PROCESS | 12183 | colorDepth:24 07:41:15 INFO - PROCESS | 12183 | Browser inner width/height: 1024/697 07:41:15 INFO - PROCESS | 12183 | __metrics 07:41:16 INFO - PROCESS | 12183 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:41:16 INFO - TEST-INFO | 12183: exit 0 07:41:16 INFO - Browser initialized. 07:41:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:41:16 INFO - TEST-INFO | started process 12314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg32xe1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:18 INFO - PROCESS | 12314 | 07:41:18 INFO - PROCESS | 12314 | (process:12371): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:41:29 INFO - PROCESS | 12314 | RSS: Main: 150622208 07:41:29 INFO - PROCESS | 12314 | 07:42:18 INFO - PROCESS | 12314 | 1452872538705 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] 07:44:30 INFO - PROCESS | 12314 | Cycle 1(1): loaded http://localhost:49506/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49506/tests/dromaeo/cssquery-ext.html) 07:44:31 INFO - PROCESS | 12314 | RSS: Main: 156393472 07:44:31 INFO - PROCESS | 12314 | 07:47:33 INFO - PROCESS | 12314 | Cycle 1(1): loaded http://localhost:49506/tests/dromaeo/cssquery-ext.html (next: http://localhost:49506/tests/dromaeo/cssquery-jquery.html) 07:47:33 INFO - PROCESS | 12314 | RSS: Main: 150982656 07:47:33 INFO - PROCESS | 12314 | 07:50:35 INFO - PROCESS | 12314 | Cycle 1(1): loaded http://localhost:49506/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49506/tests/dromaeo/cssquery-mootools.html) 07:50:36 INFO - PROCESS | 12314 | RSS: Main: 151969792 07:50:36 INFO - PROCESS | 12314 | 07:53:38 INFO - PROCESS | 12314 | Cycle 1(1): loaded http://localhost:49506/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49506/tests/dromaeo/cssquery-prototype.html) 07:53:38 INFO - PROCESS | 12314 | RSS: Main: 150421504 07:53:38 INFO - PROCESS | 12314 | 07:56:41 INFO - PROCESS | 12314 | Cycle 1(1): loaded http://localhost:49506/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49506/tests/dromaeo/cssquery-yui.html) 07:56:41 INFO - PROCESS | 12314 | RSS: Main: 150511616 07:56:41 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | Cycle 1(1): loaded http://localhost:49506/tests/dromaeo/cssquery-yui.html (next: http://localhost:49506/tests/dromaeo/cssquery-dojo.html) 07:59:44 INFO - PROCESS | 12314 | RSS: Main: 151998464 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | __start_tp_report 07:59:44 INFO - PROCESS | 12314 | _x_x_mozilla_page_load 07:59:44 INFO - PROCESS | 12314 | _x_x_mozilla_page_load_details 07:59:44 INFO - PROCESS | 12314 | |i|pagename|runs| 07:59:44 INFO - PROCESS | 12314 | |0;dojo.html;2636.5517861963463;2650.31091916102;2692.0712354237794;2703.594460830875;2716.701162872084;4508.323751437286;4601.28680054592;4617.8152873885;4650.279206722959;4673.579377855996;4557.316402539621;4630.837920672777;4639.814407423707;4682.789274482648;4700.85897423077;4291.678124140694;4304.461942257218;4308.246056940038;4370.453693288339;4381.605655491006;4157.896052598694;4274.230638485072;4274.743515389071;4317.935230971538;4323.978380108095;4175.749455032693;4221.91556168878;4287.506936702257;4315.805788739514;4334.0248444099825;4289;4296.183725092223;4307.138572285556;4313.28830742927;4330.826766929319;4163.75017498948;4235.788210589458;4243.342281946303;4285.949448543161;4328.870133895988;4514.932276015862;4583.614253252448;4600.723956562617;4611.30830375443;4620.537946205386;4888.926666099976;4891.437484689271;4894.4371397289415;4908.852734417973;4937.925931111036;4756.6432517561325;4874.65877388583;4891.951080489185;4923.729194894279;4927.852164435073;4498.617617502517;4507.9323810143205;4533.206688829442;4546.181687296318;4597.609203217764;4991.975040124777;5007.12375334315;5017.54842064216;5037.420696619863;5068.062408454448;4750.168720473903;4823.807047718052;4834.492378300228;4840.927386089212;4893.902121957541;4887.731174785421;4900.215965445512;4911.557959783637;4931.975340123348;4938.259261110862;4861.24895787845;4875.878103047452;4893.5351141642195;4899.240617704261;4932.67937584063;4730.195866702668;4853.320535125085;4860.756962151878;4861.975690121527;4901.3383193269165;4068.9389659155136;4095.2014357200655;4112.979435102805;4113.259613269581;4118.19695159441;3572.4819901114192;3611.1513794258326;3619.3485172668647;3640.9635903641156;3647.963520364762;4114.958850411517;4230.450041494586;4274.572542745701;4321.913561728811;4356.978215108904;4934.407871055496;4943.060818444484;4955.6531042826655;4977.701337919736;5009.599232061426;4264.637505811978;4284.907348626143;4289.571042895748;4301.09676967834;4325.480942286946;4266.807993640294;4352.651787856964;4355.760433176142;4378.233809083397;4428.22506061438;4600.125976064604;4646.883827904329;4656.3713898623255;4660.044690838302;4680.15757163707;4740.051989602024;4923.384576927884;4946.0107978405185;4948.084604348207;4992.5756310714;4596.931046034245;4614.584687378152;4617.284320930261;4652.511486294025;4694.671373003994;4803.18345881208;4820.132376172322;4821.5178482151505;4822.132016237111;4862.927056094232;4895.63282753802;4896.167651499182;4915.21356582945;4929.654924155275;4941.975290123526;4682.648801339981;4766.785494652819;4776.928346074742;4793.161196790617;4865.294532292868;4756.7145971241835;4759.833405830779;4762.904741905212;4763.880902977453;4766;4587.7706114693465;4610.124076425468;4662.766861656972;4676.6492513060975;4725.10223057618;4759.23852183649;4814.807407703653;4851.95148048515;4864.075825593126;4888;4680.92978605328;4719.834805781781;4723.527647235249;4749.335093087039;4796.688215265996 07:59:44 INFO - PROCESS | 12314 | |1;ext.html;485.94411642661083;516.671913335032;522.9032628963645;534.1400345443836;553.4465534465535;31522.52716209256;31963.36073278533;32001.99999999997;32100.197495062635;32117.83941080297;32227;32622.67377326226;32647.836760816164;32721.345573088583;32851.178720532;7144.642767861612;7210.315020073111;7249.601271930042;7275.345218930295;7302.1967583565765;7323.890141647853;7378.262173782632;7386.519876208029;7422.257774222561;7428.071491063617;7412.925870741305;7418.554886706788;7449.068866391701;7488;7509.849803003936;7526.059242594676;7631.084269887621;7653.808654783619;7654.349380302681;7694.961525192338;7466.85066298671;7488.176300606929;7595.050618672666;7613.923860761377;7636.083669959585;32403.6759632403;32455.35089298201;32600.510992335134;32697.346053079043;32769.836150819334;2707.4179051503825;2719.8232114912466;2722.469118521889;2908.0112761661135;3373.325334933023;26317;26450;26539.734602654113;26655.600165997526;27131.593026104623;3016.547517872315;3064.4790385634496;3091.7062879026457;3125.0937228203793;3143.5441860930036;209613;209990;210248;210356;210384;44440.777796110815;45703.31445028327;49285.753571231915;55822.04622838263;57552;50485.49514504808;50822.745886270335;51449;51502.48497515052;51881;11772.764544709058;12125.514979400901;12260.38698065111;12302.81545776814;12337.198082124632;8980.416272942239;9067;9075.81848363029;9159.175674189355;9172.174504294646;16997.235124419432;17091.401800937158;17169.570760731083;17267.53225975781;17303.65392692139;6787.524873258824;6913.239543650195;6954.165500140016;6966.860662786716;7027.262137475594;794.4200733464603;828.6768160417442;833.3250067445389;899.7570655922864;981.3130808433982;23218.187363442197;23223.651645225335;23256.7674323258;25052.87473562657;25274.747252527606;884.4074470104916;894.6600291889041;914.9085091490798;997.2996041748801;1022.3150489172124;11046.834297485544;11048.226624136234;11062.889371106347;11084.279521831055;11205.215634905642;254853;255841;257351;259166;259238;42153.57846421558;42674.14651706949;42943.35584966228;43032.784836076244;43268.13463730708;1151.5278735718316;1156.606753703728;1157.6932112990064;1166.5217260922982;1175.9529618815322;21256.25603103884;21314;21420.78579214188;21606.6758998612;22277;39481.2103757929;40829;40869;41274.79362603168;41297.1740565181;202193;202728;204168;204210;204981;26590.069347572742;26850.194494165207;27148.1855544334;27259.454810904066;27347.316317091438;31305.06084817459;31632.683673162974;36499.45250821186;36597.634023659426;36898.26203475862;26741.19776406711;26847.194584161723;27102.186934392;27391.315217119733;27496.312592185357;30296;30845.69154308518;31364;31371.686283136878;31763;25797.48405031851;25858.87070564635;26184;31352.52971205388;32078.19804504906;24474.26577202687;28156.296092597848;29253.85373073121;30944.22639433942;31692.683073168973;20813;20876.895615521826;20894.164233430492;20970.580588388453;21075.15699372008 07:59:44 INFO - PROCESS | 12314 | |2;jquery.html;326.8953934740884;340.26502754051256;340.6644455211616;341.4962929678724;341.90426680529447;11866.11004174686;12317.076219283566;13839.58481245563;14234.288285585719;14769;9424.623015079405;9664.27517936154;9677.03229677032;13576.592702218924;14687.92656036721;4375.93436098458;4484.2376795944765;4589.128065667529;4600.470945841221;4600.700954437968;4783.760811959405;4828.951710482886;4998.6750861193905;5016.648834581562;5021.297018417425;4727.527247275262;4956.355673762406;4987.451380348159;4989.251612258172;5004.949950500503;5131.743412829363;5179.430262671103;5201.973990130044;5203.843884683465;5215.817446389358;4861.416630004387;5128.282040514331;5134.1528647773075;5166.147585648364;5166.9224961625605;11322.716932076682;11492.94253528727;15812.525624231177;17816.91091544534;17834.91082544592;1751.1506919144206;1765.7263124215638;1805.1696219738935;1844.14988580035;1900.1354383755497;8347.582620868932;8443.408961372706;12549.874501254963;12621.432035558422;12637.620871373781;1815.546113471632;1829.4877434318412;1850.7871594766639;1870.812918708132;1873.1102726205079;42288.78855605702;42382.57617423817;43997.120057598986;44108.779456102835;44180.779096104634;14673;14681.632959176106;14686.485972990895;14703.264836758333;14727.779083313759;20994.47513812167;21178.2587609436;21351.14595416197;21446.249381271893;21460.678089828663;7678.577678227751;7763.534187948741;7768.689252429953;7903.683852645945;7930.722424715107;6353.047042943503;6366.6180029198395;6404.871902561923;6468.676566171673;6474.287828338973;3756.3426400379826;3884.514435695538;7156.320149585781;7248.6738096785775;7295.489315747953;1551.5267843307674;1561.664242187935;1621.3109428492844;1626.3982326539256;1630.3967532012994;727.487121579296;735.7572001239578;761.7448154868181;806.9509637471264;835.9791005224796;13314.334283285796;13319.866801332057;13557.186568805902;13732.931335343259;13807.102538335177;730.9269073092754;780.750159948811;796.7012370361115;826.9710560130487;901.2204443156622;7605.885911711329;7637.5035622684345;7803.453758236982;7915.12933577306;8010.719624813103;296010;416995;417727;417820;417979;61096;61448.38551614427;61673.07490387648;62053;62563;960.2174228004154;979.9902000980042;986.4278718343344;986.9358491698017;1025.0569476082171;12520.937395312965;13512.864871351161;13604;13776.724465510833;13947.651308717363;26452.8677356612;27081.45837083208;27294.863525682245;27808;27856.860715696293;31957.840210799728;32218.194545135622;32321.70713171447;32635.34729305448;36849;6054.939450605438;6112.8777424452155;6277.2781130170615;6376.3623637635865;6421.646809425526;7105.324994125756;8453.239208471266;9163.725088247364;9206.263498920205;9271.582778774837;7779.611019449118;8073.959630201812;8167.224113709188;8172.877406839021;8228.094909559824;8195.303399211134;8341.374396920133;8562.315014798925;8630.697925572826;8707.869381959403;2560.8975640974154;4098.422107488579;8396.832063358821;8467.872981905399;8546.145385461405;6176.382361763787;6192.195014648067;6224.339956246772;6306.558540902093;6384.648844313608;7879.566623835744;8264.132266112212;8361.498310101413;8386.203310685476;8430.199131082538 07:59:44 INFO - PROCESS | 12314 | |3;mootools.html;1336.8195293635358;1343.2209318595217;1366.8428130764964;1381.6545863534113;1445.3279225160304;6013.849653758647;6126.295476020259;6832.385085342318;6983.720651173953;7007.7547285845;6499.642519661428;6695.296993815652;6700.229473610536;6719.596824190552;6739.0902228199175;1943.4266891267075;1970.4482744831398;1972.339266345776;1975.5061234691327;1977.9307724229654;2037.103674383274;2046.4781480722395;2050.846186536008;2068.0280268273964;2074.7095406643084;2041.2855500574829;2044.642187617161;2049.938501844947;2059.34101087652;2059.927902523412;2095.6018356512213;2105.673620588811;2106.1470104607583;2108.3358741996376;2109.1457959526415;2045.8670186437835;2052.835773138145;2101.737282839645;2102.653062244743;2103.95792084159;7058.470614703918;7104.928950710479;7108.786736397917;7111.111111111111;7112.288771122898;3993.940090898639;4077.143799802045;4081.0001549620533;4085.9387109193385;4087.7751723655483;2548.796096312309;2605.817592768507;2606.1790535981295;2612.8040396970305;2643.828151170168;815.6125840225905;825.1871906172415;827.7227128911821;850.3970016518845;867.7136544940155;9535.618575256982;9537.52312384385;9544.522773861348;9554.904450955471;9559.474228917406;3663.9816800915823;3668.5047518584647;3724.906877328034;3735.3836616957897;3737.177820879402;8156.755297341089;8240.876386854203;8255.711050113217;8262.091169971298;8264.504129752235;4021.2560676274397;4025.6578190854107;4037.192561487714;4043.9191216175514;4054.270231358325;3189.9043028709175;3267.2975310308398;3587.8026708531283;3707.5180226570915;3709.6104908984707;3260.6902344277255;3296.7032967033083;3309.387763263804;3340.1816554944194;3359.664033596621;1006.6527048168371;1035.3115178406426;1035.9430231337349;1041.796849614318;1047.2355180718118;751.8496300739874;755.928186822251;756.606564586423;775.7323723315448;998.1864780204111;6184.690765461709;6189.133521307021;6423.454006409414;6577.6711164441585;6609.272979972199;948.8007518421209;953.8664586957832;957.9856302155473;959.7360725800321;989.317371013998;5189.688618682816;5198.376194856642;5217.660852044605;5228.111221092423;5249.370075590953;7787.961060194662;8200.5489698066;8207.097219305871;8272.958635206785;8342.249197572248;8401.411901166859;8411.158884111539;8414.957925210334;8415.242628163494;8428.831423371621;6463.224413070461;6477.514186436036;6518.380753828284;6538.313477084933;6606;6529.085927969993;6643.136392268974;6646.966765166143;6666.699998500176;6687.364700353459;7462.403007759258;7526.360259378014;7528.4353673473615;7586.506877052974;7655.272749088827;7643.235676432312;7647.464677472746;7876.56678882667;7920.920790792249;7954.363650908029;5397.70312632809;5576.860578485408;6206;6325.746970121144;6352.269489008823;6213.409726076015;6263.154474146114;6276.37236276387;6294.3076261612105;6320.62076275425;5844.26946631671;5950;6153.046277826944;6173.629582225081;6231;6019.067044608093;6024.487918526799;6198.81403557894;6226.12834203221;6227.844303892439;5906.557008224315;6042.75828966854;6048.274207095001;6048.546359023179;6054.939450605438;5568.220449137043;5579.721013949367;5605.943940560543;5608.383077861514;5614.578906581941;5629.774809007594;5658.603897727285;5764;5775.422457754191;5777.24895763548 07:59:44 INFO - PROCESS | 12314 | |4;prototype.html;281.9605255264263;287.7036652248184;290.28444883362505;290.5917186353172;292.03628027509217;5403.459654034595;5614.803481878135;5692.715364231787;5696.316442026952;5759.251297331341;5652.152177173426;5658;5662.858428539289;5681.318241810978;5750.3962083981105;4269.316909294514;4280.59334363235;4288.6140247377725;4288.935665965013;4290.570942905716;4272.380504826799;4280.250956082688;4290.721103128302;4297.914041719164;4302.20409224293;4010.1979604079156;4155.4182414462;4250.511191213019;4259.595338442843;4263.211305908417;4134.511575832728;4134.91730165398;4141.378793181017;4145.77699578625;4149.128682976563;3532.417151170054;3536.8231588420476;3537.1157210697324;3537.6108628050893;3540.1857572758154;5360.544353729899;5395;5400.108982018001;5410.1614249790955;5422.15956526739;4574.771261436948;4676.392069031038;4732.83435079774;4748.145333839908;4759.381280433521;5618.887622247573;5859.062549991981;5879.353271140214;5882.911756323659;5887.735051922674;3819.4079917612817;3821.5796262411113;3824.464574959508;3830.4828848105426;3832.3676593362343;6096.512279017668;6135.846603834851;6167.259928808572;6170.197874276315;6176.598521096114;3782.167923056923;3882.0877093882914;3896.7272290939927;3903.4535165076913;3937.074787424953;3937.940930886039;3982.7012974027066;3984.30274701926;3998.620131087542;4003.459532963071;4690.929636055462;4692.648051396159;4695.272232803921;4701.8354357598;4708.505606911293;5835.67903765297;5859.794907178229;5860.355360910382;5871.060630299217;5878.059510478303;1388.125480946997;1403.5929580421564;1425.8716715495448;1428.1859340176;1430.4349781836117;903.4550917930412;912.5938957164132;916.9358144929924;918.150710592699;918.2745630951607;5076.238564215323;5077.289179514871;5105.8723531912;5111.744412779346;5113;6036.8188954331445;6049.243844519435;6071.969640151771;6072.726727297194;6076.0885867119405;5081.339425874613;5084.872878178076;5089.389273287229;5093.363329583802;5094.2358646203365;3230.9838450808065;3240.060382489099;3285.5235990781202;3291.8518666660057;3293.226091868409;5683.886322273532;5689.687067211343;5694.402087780806;5698.800541981011;5705.1727499512335;6210.378962103753;6210.689465526705;6242.563020588606;6249.812505624838;6281.152044473937;5560.833175004756;5677.51741102011;5703.600747947687;5711.885762284731;5719.971400143056;6042.305134909541;6060.545459090674;6073.271207455134;6082.300535438481;6092.268927728701;5933.910991335047;5933.940660593339;5937.693707384368;5942.910856337072;5949.315828679757;5705.828825135252;5710.971445142914;5713.400092990176;5717.514011309086;5728.455796699307;3890.9221815564097;3960.801959902051;3981.2037592482197;3987.3819557968563;3989.341758609913;6039.124326972652;6044.335123136363;6054.7275372607455;6066.605670631395;6077.939220607915;5908.527317814651;5914;5922.763089476372;5937.851553711019;5949.137375080502;5909.468147866713;5914.881702366015;5920.052791553331;5925.288965324189;5932.406759324033;5640.717964101696;5773.364929857797;5793.420657934173;5796.739146738322;5800.941990580209;5938.257717785277;5948.970255148696;5952.821415357546;5957.940420595739;5959.612625179349;5706.343770466284;5734.827955161351;5791.305043394819;5792.044312688359;5795.304563452412 07:59:44 INFO - PROCESS | 12314 | |5;yui.html;651.7914267434421;718.6011763471274;727.9344858962694;744.4020962363027;745.2175216023174;11189.048930840878;11290.491927863246;11297.548098076068;11332.773344533105;11410.771784564304;10545.05094541491;10684;11263.831042534368;11334.546618135264;11368.37473938933;716.5628966330535;725.528406535752;733.0653416893476;738.04791818554;745.7799949015053;736.1975446763028;742.5136535569211;745.7837227204104;745.8433728916934;747.4058123791599;740.8518296340726;745.5489428895494;765.5598031132122;769.1116760142045;770.6223950264358;749.2507492507492;750.2909750285982;761.8742907420269;762.5958242131679;767.382257282887;554.8612846788303;555.3973938276933;556.7077284425668;573.6615396915839;578.3435800366573;10570.947145264301;10594.576216951313;10626.787464250749;10634.57461701531;10999.34003959757;10625.149988000941;10897.291676041032;10989.230753847234;11062.612808551743;11071.72320691981;8191.467554608931;8227.218414250636;8398.286145677625;8433.114522975122;8652.221300083023;3189.5056266278766;3189.984050079758;3227.3383956288903;3245.789023713451;3279.426100432415;41588.96027599304;41639;41649.1670166598;41776.32894684209;42013.36979945303;8511.616977236039;8644.654213831376;8719.694810681596;8779.868301975348;8844.425112367675;14272.85727142736;14407.42370305197;14438.278086095654;14472.421103155755;14476.348564314421;5754.4533269339345;5811.564132690065;5842.152887831326;5891.05743081105;5997.760089596367;3509.368313703507;3509.6314886937016;3519.225770330523;3526.2242306692488;3590.9640903591153;2568.895374988773;2572.5498037843304;2590.663213782196;2593.403517191019;2595.2862962685035;442.9136318417878;446.4352593968632;455.34885114286885;462.0804598848268;462.76167773596626;457.4506532533984;518.082993102207;522.1462908145135;538.7979507684619;602.0667964654767;7021.789346319619;7278.1266248049515;7667.463277570628;7766.316551255833;8299.087100418948;442.9335599660012;448.6724690975606;513.8946515964218;523.5628250410873;562.3869981719945;3457.5505184325875;3468.8612455502002;3518.5425894633536;3635.2729454108753;3661.7802931824176;48148.51851481511;49214.50785492171;49313.26030109551;49371.75314123406;49546;43171.78414107909;43172.3524147138;43781;43868;43951.340729889074;39717;40327.59672403297;40400.59599404027;40787.79606101951;40840.387394189114;7047.894281585678;7239.963800180965;7260.564366138048;7326.4138868889295;7330.853382932418;30122.24694382658;30584.694153058186;30631.387372252877;30935.535966960964;31278;35196.47205291974;35214;35925.461118083775;37630.43554346632;38957.41563876601;7866.370690344873;7880.724174653859;7920.287174154354;7996.840063198587;8073.111957684532;9449.716508504756;9471.47906865129;9565;9692.51537423112;9722.611095556098;8372.623231954698;8547.57262136903;8603.182697643713;8839.602217900081;8938.50838203905;8944.586564207677;9048.864267036131;9092.181703646704;9282.62869485213;9541.761455963657;8859.60131794058;8974.326925480746;8986.011538730865;9045.909540904508;9124;7203.855922881408;7252;7305.890411643936;7418.434685303438;7613.9238607613215;7916.168802275678;7988.241117093867;8018.198180181935;8047.074586422402;8047.315978141689 07:59:44 INFO - PROCESS | 12314 | __end_tp_report 07:59:44 INFO - PROCESS | 12314 | __start_cc_report 07:59:44 INFO - PROCESS | 12314 | _x_x_mozilla_cycle_collect,328 07:59:44 INFO - PROCESS | 12314 | __end_cc_report 07:59:44 INFO - PROCESS | 12314 | __startTimestamp1452873584593__endTimestamp 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | ------- Summary: start ------- 07:59:44 INFO - PROCESS | 12314 | Number of tests: 6 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | [#0] dojo.html Cycles:165 Average:4547.05 Median:4662.77 stddev:455.48 (9.8%) stddev-sans-first:431.52 07:59:44 INFO - PROCESS | 12314 | Values: 2636.6 2650.3 2692.1 2703.6 2716.7 4508.3 4601.3 4617.8 4650.3 4673.6 4557.3 4630.8 4639.8 4682.8 4700.9 4291.7 4304.5 4308.2 4370.5 4381.6 4157.9 4274.2 4274.7 4317.9 4324.0 4175.7 4221.9 4287.5 4315.8 4334.0 4289.0 4296.2 4307.1 4313.3 4330.8 4163.8 4235.8 4243.3 4285.9 4328.9 4514.9 4583.6 4600.7 4611.3 4620.5 4888.9 4891.4 4894.4 4908.9 4937.9 4756.6 4874.7 4892.0 4923.7 4927.9 4498.6 4507.9 4533.2 4546.2 4597.6 4992.0 5007.1 5017.5 5037.4 5068.1 4750.2 4823.8 4834.5 4840.9 4893.9 4887.7 4900.2 4911.6 4932.0 4938.3 4861.2 4875.9 4893.5 4899.2 4932.7 4730.2 4853.3 4860.8 4862.0 4901.3 4068.9 4095.2 4113.0 4113.3 4118.2 3572.5 3611.2 3619.3 3641.0 3648.0 4115.0 4230.5 4274.6 4321.9 4357.0 4934.4 4943.1 4955.7 4977.7 5009.6 4264.6 4284.9 4289.6 4301.1 4325.5 4266.8 4352.7 4355.8 4378.2 4428.2 4600.1 4646.9 4656.4 4660.0 4680.2 4740.1 4923.4 4946.0 4948.1 4992.6 4596.9 4614.6 4617.3 4652.5 4694.7 4803.2 4820.1 4821.5 4822.1 4862.9 4895.6 4896.2 4915.2 4929.7 4942.0 4682.6 4766.8 4776.9 4793.2 4865.3 4756.7 4759.8 4762.9 4763.9 4766.0 4587.8 4610.1 4662.8 4676.6 4725.1 4759.2 4814.8 4852.0 4864.1 4888.0 4680.9 4719.8 4723.5 4749.3 4796.7 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | [#1] ext.html Cycles:180 Average:36857.99 Median:31727.84 stddev:58672.85 (184.9%) stddev-sans-first:58773.88 07:59:44 INFO - PROCESS | 12314 | Values: 485.9 516.7 522.9 534.1 553.4 31522.5 31963.4 32002.0 32100.2 32117.8 32227.0 32622.7 32647.8 32721.3 32851.2 7144.6 7210.3 7249.6 7275.3 7302.2 7323.9 7378.3 7386.5 7422.3 7428.1 7412.9 7418.6 7449.1 7488.0 7509.8 7526.1 7631.1 7653.8 7654.3 7695.0 7466.9 7488.2 7595.1 7613.9 7636.1 32403.7 32455.4 32600.5 32697.3 32769.8 2707.4 2719.8 2722.5 2908.0 3373.3 26317.0 26450.0 26539.7 26655.6 27131.6 3016.5 3064.5 3091.7 3125.1 3143.5 209613.0 209990.0 210248.0 210356.0 210384.0 44440.8 45703.3 49285.8 55822.0 57552.0 50485.5 50822.7 51449.0 51502.5 51881.0 11772.8 12125.5 12260.4 12302.8 12337.2 8980.4 9067.0 9075.8 9159.2 9172.2 16997.2 17091.4 17169.6 17267.5 17303.7 6787.5 6913.2 6954.2 6966.9 7027.3 794.4 828.7 833.3 899.8 981.3 23218.2 23223.7 23256.8 25052.9 25274.7 884.4 894.7 914.9 997.3 1022.3 11046.8 11048.2 11062.9 11084.3 11205.2 254853.0 255841.0 257351.0 259166.0 259238.0 42153.6 42674.1 42943.4 43032.8 43268.1 1151.5 1156.6 1157.7 1166.5 1176.0 21256.3 21314.0 21420.8 21606.7 22277.0 39481.2 40829.0 40869.0 41274.8 41297.2 202193.0 202728.0 204168.0 204210.0 204981.0 26590.1 26850.2 27148.2 27259.5 27347.3 31305.1 31632.7 36499.5 36597.6 36898.3 26741.2 26847.2 27102.2 27391.3 27496.3 30296.0 30845.7 31364.0 31371.7 31763.0 25797.5 25858.9 26184.0 31352.5 32078.2 24474.3 28156.3 29253.9 30944.2 31692.7 20813.0 20876.9 20894.2 20970.6 21075.2 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | [#2] jquery.html Cycles:180 Average:21824.02 Median:4988.35 stddev:64709.06 (1297.2%) stddev-sans-first:64870.45 07:59:44 INFO - PROCESS | 12314 | Values: 326.9 340.3 340.7 341.5 341.9 11866.1 12317.1 13839.6 14234.3 14769.0 9424.6 9664.3 9677.0 13576.6 14687.9 4375.9 4484.2 4589.1 4600.5 4600.7 4783.8 4829.0 4998.7 5016.6 5021.3 4727.5 4956.4 4987.5 4989.3 5004.9 5131.7 5179.4 5202.0 5203.8 5215.8 4861.4 5128.3 5134.2 5166.1 5166.9 11322.7 11492.9 15812.5 17816.9 17834.9 1751.2 1765.7 1805.2 1844.1 1900.1 8347.6 8443.4 12549.9 12621.4 12637.6 1815.5 1829.5 1850.8 1870.8 1873.1 42288.8 42382.6 43997.1 44108.8 44180.8 14673.0 14681.6 14686.5 14703.3 14727.8 20994.5 21178.3 21351.1 21446.2 21460.7 7678.6 7763.5 7768.7 7903.7 7930.7 6353.0 6366.6 6404.9 6468.7 6474.3 3756.3 3884.5 7156.3 7248.7 7295.5 1551.5 1561.7 1621.3 1626.4 1630.4 727.5 735.8 761.7 807.0 836.0 13314.3 13319.9 13557.2 13732.9 13807.1 730.9 780.8 796.7 827.0 901.2 7605.9 7637.5 7803.5 7915.1 8010.7 296010.0 416995.0 417727.0 417820.0 417979.0 61096.0 61448.4 61673.1 62053.0 62563.0 960.2 980.0 986.4 986.9 1025.1 12520.9 13512.9 13604.0 13776.7 13947.7 26452.9 27081.5 27294.9 27808.0 27856.9 31957.8 32218.2 32321.7 32635.3 36849.0 6054.9 6112.9 6277.3 6376.4 6421.6 7105.3 8453.2 9163.7 9206.3 9271.6 7779.6 8074.0 8167.2 8172.9 8228.1 8195.3 8341.4 8562.3 8630.7 8707.9 2560.9 4098.4 8396.8 8467.9 8546.1 6176.4 6192.2 6224.3 6306.6 6384.6 7879.6 8264.1 8361.5 8386.2 8430.2 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | [#3] mootools.html Cycles:180 Average:4809.30 Median:6051.74 stddev:2523.51 (41.7%) stddev-sans-first:2517.10 07:59:44 INFO - PROCESS | 12314 | Values: 1336.8 1343.2 1366.8 1381.7 1445.3 6013.8 6126.3 6832.4 6983.7 7007.8 6499.6 6695.3 6700.2 6719.6 6739.1 1943.4 1970.4 1972.3 1975.5 1977.9 2037.1 2046.5 2050.8 2068.0 2074.7 2041.3 2044.6 2049.9 2059.3 2059.9 2095.6 2105.7 2106.1 2108.3 2109.1 2045.9 2052.8 2101.7 2102.7 2104.0 7058.5 7104.9 7108.8 7111.1 7112.3 3993.9 4077.1 4081.0 4085.9 4087.8 2548.8 2605.8 2606.2 2612.8 2643.8 815.6 825.2 827.7 850.4 867.7 9535.6 9537.5 9544.5 9554.9 9559.5 3664.0 3668.5 3724.9 3735.4 3737.2 8156.8 8240.9 8255.7 8262.1 8264.5 4021.3 4025.7 4037.2 4043.9 4054.3 3189.9 3267.3 3587.8 3707.5 3709.6 3260.7 3296.7 3309.4 3340.2 3359.7 1006.7 1035.3 1035.9 1041.8 1047.2 751.8 755.9 756.6 775.7 998.2 6184.7 6189.1 6423.5 6577.7 6609.3 948.8 953.9 958.0 959.7 989.3 5189.7 5198.4 5217.7 5228.1 5249.4 7788.0 8200.5 8207.1 8273.0 8342.2 8401.4 8411.2 8415.0 8415.2 8428.8 6463.2 6477.5 6518.4 6538.3 6606.0 6529.1 6643.1 6647.0 6666.7 6687.4 7462.4 7526.4 7528.4 7586.5 7655.3 7643.2 7647.5 7876.6 7920.9 7954.4 5397.7 5576.9 6206.0 6325.7 6352.3 6213.4 6263.2 6276.4 6294.3 6320.6 5844.3 5950.0 6153.0 6173.6 6231.0 6019.1 6024.5 6198.8 6226.1 6227.8 5906.6 6042.8 6048.3 6048.5 6054.9 5568.2 5579.7 5605.9 5608.4 5614.6 5629.8 5658.6 5764.0 5775.4 5777.2 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | [#4] prototype.html Cycles:180 Average:4802.14 Median:5655.08 stddev:1473.17 (26.1%) stddev-sans-first:1437.70 07:59:44 INFO - PROCESS | 12314 | Values: 282.0 287.7 290.3 290.6 292.0 5403.5 5614.8 5692.7 5696.3 5759.3 5652.2 5658.0 5662.9 5681.3 5750.4 4269.3 4280.6 4288.6 4288.9 4290.6 4272.4 4280.3 4290.7 4297.9 4302.2 4010.2 4155.4 4250.5 4259.6 4263.2 4134.5 4134.9 4141.4 4145.8 4149.1 3532.4 3536.8 3537.1 3537.6 3540.2 5360.5 5395.0 5400.1 5410.2 5422.2 4574.8 4676.4 4732.8 4748.1 4759.4 5618.9 5859.1 5879.4 5882.9 5887.7 3819.4 3821.6 3824.5 3830.5 3832.4 6096.5 6135.8 6167.3 6170.2 6176.6 3782.2 3882.1 3896.7 3903.5 3937.1 3937.9 3982.7 3984.3 3998.6 4003.5 4690.9 4692.6 4695.3 4701.8 4708.5 5835.7 5859.8 5860.4 5871.1 5878.1 1388.1 1403.6 1425.9 1428.2 1430.4 903.5 912.6 916.9 918.2 918.3 5076.2 5077.3 5105.9 5111.7 5113.0 6036.8 6049.2 6072.0 6072.7 6076.1 5081.3 5084.9 5089.4 5093.4 5094.2 3231.0 3240.1 3285.5 3291.9 3293.2 5683.9 5689.7 5694.4 5698.8 5705.2 6210.4 6210.7 6242.6 6249.8 6281.2 5560.8 5677.5 5703.6 5711.9 5720.0 6042.3 6060.5 6073.3 6082.3 6092.3 5933.9 5933.9 5937.7 5942.9 5949.3 5705.8 5711.0 5713.4 5717.5 5728.5 3890.9 3960.8 3981.2 3987.4 3989.3 6039.1 6044.3 6054.7 6066.6 6077.9 5908.5 5914.0 5922.8 5937.9 5949.1 5909.5 5914.9 5920.1 5925.3 5932.4 5640.7 5773.4 5793.4 5796.7 5800.9 5938.3 5949.0 5952.8 5957.9 5959.6 5706.3 5734.8 5791.3 5792.0 5795.3 07:59:44 INFO - PROCESS | 12314 | 07:59:44 INFO - PROCESS | 12314 | [#5] yui.html Cycles:180 Average:11574.53 Median:559.55 stddev:13670.86 (2443.2%) stddev-sans-first:13684.60 07:59:44 INFO - PROCESS | 12314 | Values: 651.8 718.6 727.9 744.4 745.2 11189.0 11290.5 11297.5 11332.8 11410.8 10545.1 10684.0 11263.8 11334.5 11368.4 716.6 725.5 733.1 738.0 745.8 736.2 742.5 745.8 745.8 747.4 740.9 745.5 765.6 769.1 770.6 749.3 750.3 761.9 762.6 767.4 554.9 555.4 556.7 573.7 578.3 10570.9 10594.6 10626.8 10634.6 10999.3 10625.1 10897.3 10989.2 11062.6 11071.7 8191.5 8227.2 8398.3 8433.1 8652.2 3189.5 3190.0 3227.3 3245.8 3279.4 41589.0 41639.0 41649.2 41776.3 42013.4 8511.6 8644.7 8719.7 8779.9 8844.4 14272.9 14407.4 14438.3 14472.4 14476.3 5754.5 5811.6 5842.2 5891.1 5997.8 3509.4 3509.6 3519.2 3526.2 3591.0 2568.9 2572.5 2590.7 2593.4 2595.3 442.9 446.4 455.3 462.1 462.8 457.5 518.1 522.1 538.8 602.1 7021.8 7278.1 7667.5 7766.3 8299.1 442.9 448.7 513.9 523.6 562.4 3457.6 3468.9 3518.5 3635.3 3661.8 48148.5 49214.5 49313.3 49371.8 49546.0 43171.8 43172.4 43781.0 43868.0 43951.3 39717.0 40327.6 40400.6 40787.8 40840.4 7047.9 7240.0 7260.6 7326.4 7330.9 30122.2 30584.7 30631.4 30935.5 31278.0 35196.5 35214.0 35925.5 37630.4 38957.4 7866.4 7880.7 7920.3 7996.8 8073.1 9449.7 9471.5 9565.0 9692.5 9722.6 8372.6 8547.6 8603.2 8839.6 8938.5 8944.6 9048.9 9092.2 9282.6 9541.8 8859.6 8974.3 8986.0 9045.9 9124.0 7203.9 7252.0 7305.9 7418.4 7613.9 7916.2 7988.2 8018.2 8047.1 8047.3 07:59:44 INFO - PROCESS | 12314 | -------- Summary: end -------- 07:59:44 INFO - PROCESS | 12314 | 07:59:45 INFO - TEST-INFO | 12314: exit 0 07:59:45 INFO - TEST-OK | dromaeo_css | took 1113540ms 07:59:45 INFO - TEST-START | kraken 07:59:45 INFO - operating with platform_type : linux_ 07:59:45 INFO - Initialising browser for kraken test... 07:59:45 INFO - TEST-INFO | started process 12553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt8zH86/profile http://localhost:49506/getInfo.html) 07:59:48 INFO - PROCESS | 12553 | 07:59:48 INFO - PROCESS | 12553 | (process:12624): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:59:49 INFO - PROCESS | 12553 | __metrics Screen width/height:1600/1200 07:59:49 INFO - PROCESS | 12553 | colorDepth:24 07:59:49 INFO - PROCESS | 12553 | Browser inner width/height: 1024/697 07:59:49 INFO - PROCESS | 12553 | __metrics 07:59:49 INFO - PROCESS | 12553 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:59:50 INFO - TEST-INFO | 12553: exit 0 07:59:50 INFO - Browser initialized. 07:59:50 INFO - Running cycle 1/1 for kraken test... 07:59:50 INFO - TEST-INFO | started process 12673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt8zH86/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:51 INFO - PROCESS | 12673 | 07:59:51 INFO - PROCESS | 12673 | (process:12730): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:00:02 INFO - PROCESS | 12673 | RSS: Main: 151216128 08:00:02 INFO - PROCESS | 12673 | 08:00:04 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49506/tests/kraken/driver.html?testName=audio-beat-detection) 08:00:05 INFO - PROCESS | 12673 | RSS: Main: 150876160 08:00:05 INFO - PROCESS | 12673 | 08:00:08 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49506/tests/kraken/driver.html?testName=audio-dft) 08:00:08 INFO - PROCESS | 12673 | RSS: Main: 154869760 08:00:08 INFO - PROCESS | 12673 | 08:00:11 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49506/tests/kraken/driver.html?testName=audio-fft) 08:00:12 INFO - PROCESS | 12673 | RSS: Main: 148131840 08:00:12 INFO - PROCESS | 12673 | 08:00:14 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49506/tests/kraken/driver.html?testName=audio-oscillator) 08:00:15 INFO - PROCESS | 12673 | RSS: Main: 148471808 08:00:15 INFO - PROCESS | 12673 | 08:00:17 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49506/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:00:18 INFO - PROCESS | 12673 | RSS: Main: 148004864 08:00:18 INFO - PROCESS | 12673 | 08:00:21 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49506/tests/kraken/driver.html?testName=imaging-darkroom) 08:00:21 INFO - PROCESS | 12673 | RSS: Main: 147910656 08:00:21 INFO - PROCESS | 12673 | 08:00:25 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49506/tests/kraken/driver.html?testName=imaging-desaturate) 08:00:25 INFO - PROCESS | 12673 | RSS: Main: 147832832 08:00:25 INFO - PROCESS | 12673 | 08:00:28 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49506/tests/kraken/driver.html?testName=json-parse-financial) 08:00:29 INFO - PROCESS | 12673 | RSS: Main: 147947520 08:00:29 INFO - PROCESS | 12673 | 08:00:31 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49506/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:00:31 INFO - PROCESS | 12673 | RSS: Main: 149065728 08:00:31 INFO - PROCESS | 12673 | 08:00:33 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:00:34 INFO - PROCESS | 12673 | RSS: Main: 149282816 08:00:34 INFO - PROCESS | 12673 | 08:00:36 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:00:36 INFO - PROCESS | 12673 | RSS: Main: 149413888 08:00:36 INFO - PROCESS | 12673 | 08:00:39 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:00:40 INFO - PROCESS | 12673 | RSS: Main: 149221376 08:00:40 INFO - PROCESS | 12673 | 08:00:42 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:00:43 INFO - PROCESS | 12673 | RSS: Main: 150470656 08:00:43 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | Cycle 1(1): loaded http://localhost:49506/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49506/tests/kraken/driver.html?testName=ai-astar) 08:00:45 INFO - PROCESS | 12673 | RSS: Main: 149975040 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | __start_tp_report 08:00:45 INFO - PROCESS | 12673 | _x_x_mozilla_page_load 08:00:45 INFO - PROCESS | 12673 | _x_x_mozilla_page_load_details 08:00:45 INFO - PROCESS | 12673 | |i|pagename|runs| 08:00:45 INFO - PROCESS | 12673 | |0;ai-astar;113;109;113;113;115;124;114;114;114;114 08:00:45 INFO - PROCESS | 12673 | |1;audio-beat-detection;160;129;156;170;138;162;165;129;168;135 08:00:45 INFO - PROCESS | 12673 | |2;audio-dft;162;163;163;161;163;162;171;165;166;163 08:00:45 INFO - PROCESS | 12673 | |3;audio-fft;76;85;73;75;73;74;126;73;73;73 08:00:45 INFO - PROCESS | 12673 | |4;audio-oscillator;97;99;132;97;97;98;140;97;98;130 08:00:45 INFO - PROCESS | 12673 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;111;109;110 08:00:45 INFO - PROCESS | 12673 | |6;imaging-darkroom;148;147;149;149;148;148;148;149;148;147 08:00:45 INFO - PROCESS | 12673 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;95;96 08:00:45 INFO - PROCESS | 12673 | |8;json-parse-financial;71;69;71;71;70;70;70;70;68;68 08:00:45 INFO - PROCESS | 12673 | |9;json-stringify-tinderbox;70;67;71;67;72;68;68;67;67;70 08:00:45 INFO - PROCESS | 12673 | |10;stanford-crypto-aes;86;83;84;86;84;85;84;86;85;85 08:00:45 INFO - PROCESS | 12673 | |11;stanford-crypto-ccm;129;124;126;125;139;125;131;132;127;127 08:00:45 INFO - PROCESS | 12673 | |12;stanford-crypto-pbkdf2;137;154;142;149;151;140;152;151;139;150 08:00:45 INFO - PROCESS | 12673 | |13;stanford-crypto-sha256-iterative;72;73;74;75;71;70;73;74;70;71 08:00:45 INFO - PROCESS | 12673 | __end_tp_report 08:00:45 INFO - PROCESS | 12673 | __start_cc_report 08:00:45 INFO - PROCESS | 12673 | _x_x_mozilla_cycle_collect,817 08:00:45 INFO - PROCESS | 12673 | __end_cc_report 08:00:45 INFO - PROCESS | 12673 | __startTimestamp1452873645314__endTimestamp 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | ------- Summary: start ------- 08:00:45 INFO - PROCESS | 12673 | Number of tests: 14 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:3.77 (3.3%) stddev-sans-first:3.97 08:00:45 INFO - PROCESS | 12673 | Values: 113.0 109.0 113.0 113.0 115.0 124.0 114.0 114.0 114.0 114.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:161.00 stddev:16.55 (10.3%) stddev-sans-first:17.25 08:00:45 INFO - PROCESS | 12673 | Values: 160.0 129.0 156.0 170.0 138.0 162.0 165.0 129.0 168.0 135.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.88 (1.8%) stddev-sans-first:2.98 08:00:45 INFO - PROCESS | 12673 | Values: 162.0 163.0 163.0 161.0 163.0 162.0 171.0 165.0 166.0 163.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#3] audio-fft Cycles:10 Average:80.10 Median:73.50 stddev:16.54 (22.5%) stddev-sans-first:17.48 08:00:45 INFO - PROCESS | 12673 | Values: 76.0 85.0 73.0 75.0 73.0 74.0 126.0 73.0 73.0 73.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:97.00 stddev:17.78 (18.3%) stddev-sans-first:18.37 08:00:45 INFO - PROCESS | 12673 | Values: 97.0 99.0 132.0 97.0 97.0 98.0 140.0 97.0 98.0 130.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:00:45 INFO - PROCESS | 12673 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 111.0 109.0 110.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:00:45 INFO - PROCESS | 12673 | Values: 148.0 147.0 149.0 149.0 148.0 148.0 148.0 149.0 148.0 147.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:00:45 INFO - PROCESS | 12673 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:70.00 stddev:1.14 (1.6%) stddev-sans-first:1.12 08:00:45 INFO - PROCESS | 12673 | Values: 71.0 69.0 71.0 71.0 70.0 70.0 70.0 70.0 68.0 68.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:1.94 08:00:45 INFO - PROCESS | 12673 | Values: 70.0 67.0 71.0 67.0 72.0 68.0 68.0 67.0 67.0 70.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 08:00:45 INFO - PROCESS | 12673 | Values: 86.0 83.0 84.0 86.0 84.0 85.0 84.0 86.0 85.0 85.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:128.00 stddev:4.53 (3.5%) stddev-sans-first:4.80 08:00:45 INFO - PROCESS | 12673 | Values: 129.0 124.0 126.0 125.0 139.0 125.0 131.0 132.0 127.0 127.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:150.50 stddev:6.28 (4.2%) stddev-sans-first:5.64 08:00:45 INFO - PROCESS | 12673 | Values: 137.0 154.0 142.0 149.0 151.0 140.0 152.0 151.0 139.0 150.0 08:00:45 INFO - PROCESS | 12673 | 08:00:45 INFO - PROCESS | 12673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:1.77 (2.4%) stddev-sans-first:1.87 08:00:45 INFO - PROCESS | 12673 | Values: 72.0 73.0 74.0 75.0 71.0 70.0 73.0 74.0 70.0 71.0 08:00:45 INFO - PROCESS | 12673 | -------- Summary: end -------- 08:00:45 INFO - PROCESS | 12673 | 08:00:46 INFO - TEST-INFO | 12673: exit 0 08:00:46 INFO - TEST-OK | kraken | took 60983ms 08:00:46 INFO - TEST-START | v8_7 08:00:46 INFO - operating with platform_type : linux_ 08:00:46 INFO - Initialising browser for v8_7 test... 08:00:46 INFO - TEST-INFO | started process 12958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeowHZh/profile http://localhost:49506/getInfo.html) 08:00:49 INFO - PROCESS | 12958 | 08:00:49 INFO - PROCESS | 12958 | (process:13032): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:00:50 INFO - PROCESS | 12958 | __metrics Screen width/height:1600/1200 08:00:50 INFO - PROCESS | 12958 | colorDepth:24 08:00:50 INFO - PROCESS | 12958 | Browser inner width/height: 1024/697 08:00:50 INFO - PROCESS | 12958 | __metrics 08:00:50 INFO - PROCESS | 12958 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:00:51 INFO - TEST-INFO | 12958: exit 0 08:00:51 INFO - Browser initialized. 08:00:51 INFO - Running cycle 1/1 for v8_7 test... 08:00:51 INFO - TEST-INFO | started process 13081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeowHZh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:52 INFO - PROCESS | 13081 | 08:00:52 INFO - PROCESS | 13081 | (process:13137): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:01:03 INFO - PROCESS | 13081 | RSS: Main: 150511616 08:01:03 INFO - PROCESS | 13081 | 08:01:25 INFO - PROCESS | 13081 | Cycle 1(1): loaded http://localhost:49506/tests/v8_7/run.html (next: http://localhost:49506/tests/v8_7/run.html) 08:01:26 INFO - PROCESS | 13081 | RSS: Main: 146186240 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | __start_tp_report 08:01:26 INFO - PROCESS | 13081 | _x_x_mozilla_page_load 08:01:26 INFO - PROCESS | 13081 | _x_x_mozilla_page_load_details 08:01:26 INFO - PROCESS | 13081 | |i|pagename|runs| 08:01:26 INFO - PROCESS | 13081 | |0;Richards;165.8649859014762 08:01:26 INFO - PROCESS | 13081 | |1;DeltaBlue;186.88095683049897 08:01:26 INFO - PROCESS | 13081 | |2;Encrypt;277.9321845469705 08:01:26 INFO - PROCESS | 13081 | |3;Decrypt;5291.005291005291 08:01:26 INFO - PROCESS | 13081 | |4;RayTrace;1086.9565217391305 08:01:26 INFO - PROCESS | 13081 | |5;Earley;710.7320540156361 08:01:26 INFO - PROCESS | 13081 | |6;Boyer;12469.135802469136 08:01:26 INFO - PROCESS | 13081 | |7;RegExp;43382.97872340425 08:01:26 INFO - PROCESS | 13081 | |8;Splay;604.5949214026602 08:01:26 INFO - PROCESS | 13081 | |9;NavierStokes;4830.917874396136 08:01:26 INFO - PROCESS | 13081 | __end_tp_report 08:01:26 INFO - PROCESS | 13081 | __startTimestamp1452873686190__endTimestamp 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | ------- Summary: start ------- 08:01:26 INFO - PROCESS | 13081 | Number of tests: 10 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 165.9 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#1] DeltaBlue Cycles:1 Average:186.88 Median:186.88 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 186.9 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 277.9 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#3] Decrypt Cycles:1 Average:5291.01 Median:5291.01 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 5291.0 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 1087.0 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#5] Earley Cycles:1 Average:710.73 Median:710.73 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 710.7 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#6] Boyer Cycles:1 Average:12469.14 Median:12469.14 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 12469.1 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#7] RegExp Cycles:1 Average:43382.98 Median:43382.98 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 43383.0 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#8] Splay Cycles:1 Average:604.59 Median:604.59 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 604.6 08:01:26 INFO - PROCESS | 13081 | 08:01:26 INFO - PROCESS | 13081 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:01:26 INFO - PROCESS | 13081 | Values: 4830.9 08:01:26 INFO - PROCESS | 13081 | -------- Summary: end -------- 08:01:26 INFO - PROCESS | 13081 | 08:01:27 INFO - TEST-INFO | 13081: exit 0 08:01:27 INFO - TEST-OK | v8_7 | took 40882ms 08:01:27 INFO - SUITE-END | took 1215s 08:01:27 INFO - Completed test suite (00:20:15) 08:01:27 INFO - Working with test: dromaeo_css 08:01:27 INFO - Generating results file: dromaeo_css 08:01:27 INFO - Working with test: kraken 08:01:27 INFO - Generating results file: kraken 08:01:27 INFO - javascript benchmark 08:01:27 INFO - Working with test: v8_7 08:01:27 INFO - Generating results file: v8_7 08:01:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 08:01:27 INFO - process_Request line: dromaeo_css 5968.77 graph.html#tests=[[72,132,43]] 08:01:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:27 INFO - process_Request line: kraken 1542.60 graph.html#tests=[[232,132,43]] 08:01:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:27 INFO - process_Request line: v8_7 20215.06 graph.html#tests=[[230,132,43]] 08:01:27 INFO - RETURN: dromaeo_css: 5968.77 08:01:27 INFO - RETURN: kraken: 1542.60 08:01:27 INFO - RETURN: v8_7: 20215.06 08:01:27 INFO - javascript benchmark 08:01:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2636.5517861963463, 2650.31091916102, 2692.0712354237794, 2703.594460830875, 2716.701162872084, 4508.323751437286, 4601.28680054592, 4617.8152873885, 4650.279206722959, 4673.579377855996, 4557.316402539621, 4630.837920672777, 4639.814407423707, 4682.789274482648, 4700.85897423077, 4291.678124140694, 4304.461942257218, 4308.246056940038, 4370.453693288339, 4381.605655491006, 4157.896052598694, 4274.230638485072, 4274.743515389071, 4317.935230971538, 4323.978380108095, 4175.749455032693, 4221.91556168878, 4287.506936702257, 4315.805788739514, 4334.0248444099825, 4289.0, 4296.183725092223, 4307.138572285556, 4313.28830742927, 4330.826766929319, 4163.75017498948, 4235.788210589458, 4243.342281946303, 4285.949448543161, 4328.870133895988, 4514.932276015862, 4583.614253252448, 4600.723956562617, 4611.30830375443, 4620.537946205386, 4888.926666099976, 4891.437484689271, 4894.4371397289415, 4908.852734417973, 4937.925931111036, 4756.6432517561325, 4874.65877388583, 4891.951080489185, 4923.729194894279, 4927.852164435073, 4498.617617502517, 4507.9323810143205, 4533.206688829442, 4546.181687296318, 4597.609203217764, 4991.975040124777, 5007.12375334315, 5017.54842064216, 5037.420696619863, 5068.062408454448, 4750.168720473903, 4823.807047718052, 4834.492378300228, 4840.927386089212, 4893.902121957541, 4887.731174785421, 4900.215965445512, 4911.557959783637, 4931.975340123348, 4938.259261110862, 4861.24895787845, 4875.878103047452, 4893.5351141642195, 4899.240617704261, 4932.67937584063, 4730.195866702668, 4853.320535125085, 4860.756962151878, 4861.975690121527, 4901.3383193269165, 4068.9389659155136, 4095.2014357200655, 4112.979435102805, 4113.259613269581, 4118.19695159441, 3572.4819901114192, 3611.1513794258326, 3619.3485172668647, 3640.9635903641156, 3647.963520364762, 4114.958850411517, 4230.450041494586, 4274.572542745701, 4321.913561728811, 4356.978215108904, 4934.407871055496, 4943.060818444484, 4955.6531042826655, 4977.701337919736, 5009.599232061426, 4264.637505811978, 4284.907348626143, 4289.571042895748, 4301.09676967834, 4325.480942286946, 4266.807993640294, 4352.651787856964, 4355.760433176142, 4378.233809083397, 4428.22506061438, 4600.125976064604, 4646.883827904329, 4656.3713898623255, 4660.044690838302, 4680.15757163707, 4740.051989602024, 4923.384576927884, 4946.0107978405185, 4948.084604348207, 4992.5756310714, 4596.931046034245, 4614.584687378152, 4617.284320930261, 4652.511486294025, 4694.671373003994, 4803.18345881208, 4820.132376172322, 4821.5178482151505, 4822.132016237111, 4862.927056094232, 4895.63282753802, 4896.167651499182, 4915.21356582945, 4929.654924155275, 4941.975290123526, 4682.648801339981, 4766.785494652819, 4776.928346074742, 4793.161196790617, 4865.294532292868, 4756.7145971241835, 4759.833405830779, 4762.904741905212, 4763.880902977453, 4766.0, 4587.7706114693465, 4610.124076425468, 4662.766861656972, 4676.6492513060975, 4725.10223057618, 4759.23852183649, 4814.807407703653, 4851.95148048515, 4864.075825593126, 4888.0, 4680.92978605328, 4719.834805781781, 4723.527647235249, 4749.335093087039, 4796.688215265996], "unit": "score", "name": "dojo.html", "value": 4519.710606986956}, {"lowerIsBetter": false, "replicates": [485.94411642661083, 516.671913335032, 522.9032628963645, 534.1400345443836, 553.4465534465535, 31522.52716209256, 31963.36073278533, 32001.99999999997, 32100.197495062635, 32117.83941080297, 32227.0, 32622.67377326226, 32647.836760816164, 32721.345573088583, 32851.178720532, 7144.642767861612, 7210.315020073111, 7249.601271930042, 7275.345218930295, 7302.1967583565765, 7323.890141647853, 7378.262173782632, 7386.519876208029, 7422.257774222561, 7428.071491063617, 7412.925870741305, 7418.554886706788, 7449.068866391701, 7488.0, 7509.849803003936, 7526.059242594676, 7631.084269887621, 7653.808654783619, 7654.349380302681, 7694.961525192338, 7466.85066298671, 7488.176300606929, 7595.050618672666, 7613.923860761377, 7636.083669959585, 32403.6759632403, 32455.35089298201, 32600.510992335134, 32697.346053079043, 32769.836150819334, 2707.4179051503825, 2719.8232114912466, 2722.469118521889, 2908.0112761661135, 3373.325334933023, 26317.0, 26450.0, 26539.734602654113, 26655.600165997526, 27131.593026104623, 3016.547517872315, 3064.4790385634496, 3091.7062879026457, 3125.0937228203793, 3143.5441860930036, 209613.0, 209990.0, 210248.0, 210356.0, 210384.0, 44440.777796110815, 45703.31445028327, 49285.753571231915, 55822.04622838263, 57552.0, 50485.49514504808, 50822.745886270335, 51449.0, 51502.48497515052, 51881.0, 11772.764544709058, 12125.514979400901, 12260.38698065111, 12302.81545776814, 12337.198082124632, 8980.416272942239, 9067.0, 9075.81848363029, 9159.175674189355, 9172.174504294646, 16997.235124419432, 17091.401800937158, 17169.570760731083, 17267.53225975781, 17303.65392692139, 6787.524873258824, 6913.239543650195, 6954.165500140016, 6966.860662786716, 7027.262137475594, 794.4200733464603, 828.6768160417442, 833.3250067445389, 899.7570655922864, 981.3130808433982, 23218.187363442197, 23223.651645225335, 23256.7674323258, 25052.87473562657, 25274.747252527606, 884.4074470104916, 894.6600291889041, 914.9085091490798, 997.2996041748801, 1022.3150489172124, 11046.834297485544, 11048.226624136234, 11062.889371106347, 11084.279521831055, 11205.215634905642, 254853.0, 255841.0, 257351.0, 259166.0, 259238.0, 42153.57846421558, 42674.14651706949, 42943.35584966228, 43032.784836076244, 43268.13463730708, 1151.5278735718316, 1156.606753703728, 1157.6932112990064, 1166.5217260922982, 1175.9529618815322, 21256.25603103884, 21314.0, 21420.78579214188, 21606.6758998612, 22277.0, 39481.2103757929, 40829.0, 40869.0, 41274.79362603168, 41297.1740565181, 202193.0, 202728.0, 204168.0, 204210.0, 204981.0, 26590.069347572742, 26850.194494165207, 27148.1855544334, 27259.454810904066, 27347.316317091438, 31305.06084817459, 31632.683673162974, 36499.45250821186, 36597.634023659426, 36898.26203475862, 26741.19776406711, 26847.194584161723, 27102.186934392, 27391.315217119733, 27496.312592185357, 30296.0, 30845.69154308518, 31364.0, 31371.686283136878, 31763.0, 25797.48405031851, 25858.87070564635, 26184.0, 31352.52971205388, 32078.19804504906, 24474.26577202687, 28156.296092597848, 29253.85373073121, 30944.22639433942, 31692.683073168973, 20813.0, 20876.895615521826, 20894.164233430492, 20970.580588388453, 21075.15699372008], "unit": "score", "name": "ext.html", "value": 15321.372972968295}, {"lowerIsBetter": false, "replicates": [326.8953934740884, 340.26502754051256, 340.6644455211616, 341.4962929678724, 341.90426680529447, 11866.11004174686, 12317.076219283566, 13839.58481245563, 14234.288285585719, 14769.0, 9424.623015079405, 9664.27517936154, 9677.03229677032, 13576.592702218924, 14687.92656036721, 4375.93436098458, 4484.2376795944765, 4589.128065667529, 4600.470945841221, 4600.700954437968, 4783.760811959405, 4828.951710482886, 4998.6750861193905, 5016.648834581562, 5021.297018417425, 4727.527247275262, 4956.355673762406, 4987.451380348159, 4989.251612258172, 5004.949950500503, 5131.743412829363, 5179.430262671103, 5201.973990130044, 5203.843884683465, 5215.817446389358, 4861.416630004387, 5128.282040514331, 5134.1528647773075, 5166.147585648364, 5166.9224961625605, 11322.716932076682, 11492.94253528727, 15812.525624231177, 17816.91091544534, 17834.91082544592, 1751.1506919144206, 1765.7263124215638, 1805.1696219738935, 1844.14988580035, 1900.1354383755497, 8347.582620868932, 8443.408961372706, 12549.874501254963, 12621.432035558422, 12637.620871373781, 1815.546113471632, 1829.4877434318412, 1850.7871594766639, 1870.812918708132, 1873.1102726205079, 42288.78855605702, 42382.57617423817, 43997.120057598986, 44108.779456102835, 44180.779096104634, 14673.0, 14681.632959176106, 14686.485972990895, 14703.264836758333, 14727.779083313759, 20994.47513812167, 21178.2587609436, 21351.14595416197, 21446.249381271893, 21460.678089828663, 7678.577678227751, 7763.534187948741, 7768.689252429953, 7903.683852645945, 7930.722424715107, 6353.047042943503, 6366.6180029198395, 6404.871902561923, 6468.676566171673, 6474.287828338973, 3756.3426400379826, 3884.514435695538, 7156.320149585781, 7248.6738096785775, 7295.489315747953, 1551.5267843307674, 1561.664242187935, 1621.3109428492844, 1626.3982326539256, 1630.3967532012994, 727.487121579296, 735.7572001239578, 761.7448154868181, 806.9509637471264, 835.9791005224796, 13314.334283285796, 13319.866801332057, 13557.186568805902, 13732.931335343259, 13807.102538335177, 730.9269073092754, 780.750159948811, 796.7012370361115, 826.9710560130487, 901.2204443156622, 7605.885911711329, 7637.5035622684345, 7803.453758236982, 7915.12933577306, 8010.719624813103, 296010.0, 416995.0, 417727.0, 417820.0, 417979.0, 61096.0, 61448.38551614427, 61673.07490387648, 62053.0, 62563.0, 960.2174228004154, 979.9902000980042, 986.4278718343344, 986.9358491698017, 1025.0569476082171, 12520.937395312965, 13512.864871351161, 13604.0, 13776.724465510833, 13947.651308717363, 26452.8677356612, 27081.45837083208, 27294.863525682245, 27808.0, 27856.860715696293, 31957.840210799728, 32218.194545135622, 32321.70713171447, 32635.34729305448, 36849.0, 6054.939450605438, 6112.8777424452155, 6277.2781130170615, 6376.3623637635865, 6421.646809425526, 7105.324994125756, 8453.239208471266, 9163.725088247364, 9206.263498920205, 9271.582778774837, 7779.611019449118, 8073.959630201812, 8167.224113709188, 8172.877406839021, 8228.094909559824, 8195.303399211134, 8341.374396920133, 8562.315014798925, 8630.697925572826, 8707.869381959403, 2560.8975640974154, 4098.422107488579, 8396.832063358821, 8467.872981905399, 8546.145385461405, 6176.382361763787, 6192.195014648067, 6224.339956246772, 6306.558540902093, 6384.648844313608, 7879.566623835744, 8264.132266112212, 8361.498310101413, 8386.203310685476, 8430.199131082538], "unit": "score", "name": "jquery.html", "value": 7307.378718942696}, {"lowerIsBetter": false, "replicates": [1336.8195293635358, 1343.2209318595217, 1366.8428130764964, 1381.6545863534113, 1445.3279225160304, 6013.849653758647, 6126.295476020259, 6832.385085342318, 6983.720651173953, 7007.7547285845, 6499.642519661428, 6695.296993815652, 6700.229473610536, 6719.596824190552, 6739.0902228199175, 1943.4266891267075, 1970.4482744831398, 1972.339266345776, 1975.5061234691327, 1977.9307724229654, 2037.103674383274, 2046.4781480722395, 2050.846186536008, 2068.0280268273964, 2074.7095406643084, 2041.2855500574829, 2044.642187617161, 2049.938501844947, 2059.34101087652, 2059.927902523412, 2095.6018356512213, 2105.673620588811, 2106.1470104607583, 2108.3358741996376, 2109.1457959526415, 2045.8670186437835, 2052.835773138145, 2101.737282839645, 2102.653062244743, 2103.95792084159, 7058.470614703918, 7104.928950710479, 7108.786736397917, 7111.111111111111, 7112.288771122898, 3993.940090898639, 4077.143799802045, 4081.0001549620533, 4085.9387109193385, 4087.7751723655483, 2548.796096312309, 2605.817592768507, 2606.1790535981295, 2612.8040396970305, 2643.828151170168, 815.6125840225905, 825.1871906172415, 827.7227128911821, 850.3970016518845, 867.7136544940155, 9535.618575256982, 9537.52312384385, 9544.522773861348, 9554.904450955471, 9559.474228917406, 3663.9816800915823, 3668.5047518584647, 3724.906877328034, 3735.3836616957897, 3737.177820879402, 8156.755297341089, 8240.876386854203, 8255.711050113217, 8262.091169971298, 8264.504129752235, 4021.2560676274397, 4025.6578190854107, 4037.192561487714, 4043.9191216175514, 4054.270231358325, 3189.9043028709175, 3267.2975310308398, 3587.8026708531283, 3707.5180226570915, 3709.6104908984707, 3260.6902344277255, 3296.7032967033083, 3309.387763263804, 3340.1816554944194, 3359.664033596621, 1006.6527048168371, 1035.3115178406426, 1035.9430231337349, 1041.796849614318, 1047.2355180718118, 751.8496300739874, 755.928186822251, 756.606564586423, 775.7323723315448, 998.1864780204111, 6184.690765461709, 6189.133521307021, 6423.454006409414, 6577.6711164441585, 6609.272979972199, 948.8007518421209, 953.8664586957832, 957.9856302155473, 959.7360725800321, 989.317371013998, 5189.688618682816, 5198.376194856642, 5217.660852044605, 5228.111221092423, 5249.370075590953, 7787.961060194662, 8200.5489698066, 8207.097219305871, 8272.958635206785, 8342.249197572248, 8401.411901166859, 8411.158884111539, 8414.957925210334, 8415.242628163494, 8428.831423371621, 6463.224413070461, 6477.514186436036, 6518.380753828284, 6538.313477084933, 6606.0, 6529.085927969993, 6643.136392268974, 6646.966765166143, 6666.699998500176, 6687.364700353459, 7462.403007759258, 7526.360259378014, 7528.4353673473615, 7586.506877052974, 7655.272749088827, 7643.235676432312, 7647.464677472746, 7876.56678882667, 7920.920790792249, 7954.363650908029, 5397.70312632809, 5576.860578485408, 6206.0, 6325.746970121144, 6352.269489008823, 6213.409726076015, 6263.154474146114, 6276.37236276387, 6294.3076261612105, 6320.62076275425, 5844.26946631671, 5950.0, 6153.046277826944, 6173.629582225081, 6231.0, 6019.067044608093, 6024.487918526799, 6198.81403557894, 6226.12834203221, 6227.844303892439, 5906.557008224315, 6042.75828966854, 6048.274207095001, 6048.546359023179, 6054.939450605438, 5568.220449137043, 5579.721013949367, 5605.943940560543, 5608.383077861514, 5614.578906581941, 5629.774809007594, 5658.603897727285, 5764.0, 5775.422457754191, 5777.24895763548], "unit": "score", "name": "mootools.html", "value": 3924.7763814854216}, {"lowerIsBetter": false, "replicates": [281.9605255264263, 287.7036652248184, 290.28444883362505, 290.5917186353172, 292.03628027509217, 5403.459654034595, 5614.803481878135, 5692.715364231787, 5696.316442026952, 5759.251297331341, 5652.152177173426, 5658.0, 5662.858428539289, 5681.318241810978, 5750.3962083981105, 4269.316909294514, 4280.59334363235, 4288.6140247377725, 4288.935665965013, 4290.570942905716, 4272.380504826799, 4280.250956082688, 4290.721103128302, 4297.914041719164, 4302.20409224293, 4010.1979604079156, 4155.4182414462, 4250.511191213019, 4259.595338442843, 4263.211305908417, 4134.511575832728, 4134.91730165398, 4141.378793181017, 4145.77699578625, 4149.128682976563, 3532.417151170054, 3536.8231588420476, 3537.1157210697324, 3537.6108628050893, 3540.1857572758154, 5360.544353729899, 5395.0, 5400.108982018001, 5410.1614249790955, 5422.15956526739, 4574.771261436948, 4676.392069031038, 4732.83435079774, 4748.145333839908, 4759.381280433521, 5618.887622247573, 5859.062549991981, 5879.353271140214, 5882.911756323659, 5887.735051922674, 3819.4079917612817, 3821.5796262411113, 3824.464574959508, 3830.4828848105426, 3832.3676593362343, 6096.512279017668, 6135.846603834851, 6167.259928808572, 6170.197874276315, 6176.598521096114, 3782.167923056923, 3882.0877093882914, 3896.7272290939927, 3903.4535165076913, 3937.074787424953, 3937.940930886039, 3982.7012974027066, 3984.30274701926, 3998.620131087542, 4003.459532963071, 4690.929636055462, 4692.648051396159, 4695.272232803921, 4701.8354357598, 4708.505606911293, 5835.67903765297, 5859.794907178229, 5860.355360910382, 5871.060630299217, 5878.059510478303, 1388.125480946997, 1403.5929580421564, 1425.8716715495448, 1428.1859340176, 1430.4349781836117, 903.4550917930412, 912.5938957164132, 916.9358144929924, 918.150710592699, 918.2745630951607, 5076.238564215323, 5077.289179514871, 5105.8723531912, 5111.744412779346, 5113.0, 6036.8188954331445, 6049.243844519435, 6071.969640151771, 6072.726727297194, 6076.0885867119405, 5081.339425874613, 5084.872878178076, 5089.389273287229, 5093.363329583802, 5094.2358646203365, 3230.9838450808065, 3240.060382489099, 3285.5235990781202, 3291.8518666660057, 3293.226091868409, 5683.886322273532, 5689.687067211343, 5694.402087780806, 5698.800541981011, 5705.1727499512335, 6210.378962103753, 6210.689465526705, 6242.563020588606, 6249.812505624838, 6281.152044473937, 5560.833175004756, 5677.51741102011, 5703.600747947687, 5711.885762284731, 5719.971400143056, 6042.305134909541, 6060.545459090674, 6073.271207455134, 6082.300535438481, 6092.268927728701, 5933.910991335047, 5933.940660593339, 5937.693707384368, 5942.910856337072, 5949.315828679757, 5705.828825135252, 5710.971445142914, 5713.400092990176, 5717.514011309086, 5728.455796699307, 3890.9221815564097, 3960.801959902051, 3981.2037592482197, 3987.3819557968563, 3989.341758609913, 6039.124326972652, 6044.335123136363, 6054.7275372607455, 6066.605670631395, 6077.939220607915, 5908.527317814651, 5914.0, 5922.763089476372, 5937.851553711019, 5949.137375080502, 5909.468147866713, 5914.881702366015, 5920.052791553331, 5925.288965324189, 5932.406759324033, 5640.717964101696, 5773.364929857797, 5793.420657934173, 5796.739146738322, 5800.941990580209, 5938.257717785277, 5948.970255148696, 5952.821415357546, 5957.940420595739, 5959.612625179349, 5706.343770466284, 5734.827955161351, 5791.305043394819, 5792.044312688359, 5795.304563452412], "unit": "score", "name": "prototype.html", "value": 4312.615024351023}, {"lowerIsBetter": false, "replicates": [651.7914267434421, 718.6011763471274, 727.9344858962694, 744.4020962363027, 745.2175216023174, 11189.048930840878, 11290.491927863246, 11297.548098076068, 11332.773344533105, 11410.771784564304, 10545.05094541491, 10684.0, 11263.831042534368, 11334.546618135264, 11368.37473938933, 716.5628966330535, 725.528406535752, 733.0653416893476, 738.04791818554, 745.7799949015053, 736.1975446763028, 742.5136535569211, 745.7837227204104, 745.8433728916934, 747.4058123791599, 740.8518296340726, 745.5489428895494, 765.5598031132122, 769.1116760142045, 770.6223950264358, 749.2507492507492, 750.2909750285982, 761.8742907420269, 762.5958242131679, 767.382257282887, 554.8612846788303, 555.3973938276933, 556.7077284425668, 573.6615396915839, 578.3435800366573, 10570.947145264301, 10594.576216951313, 10626.787464250749, 10634.57461701531, 10999.34003959757, 10625.149988000941, 10897.291676041032, 10989.230753847234, 11062.612808551743, 11071.72320691981, 8191.467554608931, 8227.218414250636, 8398.286145677625, 8433.114522975122, 8652.221300083023, 3189.5056266278766, 3189.984050079758, 3227.3383956288903, 3245.789023713451, 3279.426100432415, 41588.96027599304, 41639.0, 41649.1670166598, 41776.32894684209, 42013.36979945303, 8511.616977236039, 8644.654213831376, 8719.694810681596, 8779.868301975348, 8844.425112367675, 14272.85727142736, 14407.42370305197, 14438.278086095654, 14472.421103155755, 14476.348564314421, 5754.4533269339345, 5811.564132690065, 5842.152887831326, 5891.05743081105, 5997.760089596367, 3509.368313703507, 3509.6314886937016, 3519.225770330523, 3526.2242306692488, 3590.9640903591153, 2568.895374988773, 2572.5498037843304, 2590.663213782196, 2593.403517191019, 2595.2862962685035, 442.9136318417878, 446.4352593968632, 455.34885114286885, 462.0804598848268, 462.76167773596626, 457.4506532533984, 518.082993102207, 522.1462908145135, 538.7979507684619, 602.0667964654767, 7021.789346319619, 7278.1266248049515, 7667.463277570628, 7766.316551255833, 8299.087100418948, 442.9335599660012, 448.6724690975606, 513.8946515964218, 523.5628250410873, 562.3869981719945, 3457.5505184325875, 3468.8612455502002, 3518.5425894633536, 3635.2729454108753, 3661.7802931824176, 48148.51851481511, 49214.50785492171, 49313.26030109551, 49371.75314123406, 49546.0, 43171.78414107909, 43172.3524147138, 43781.0, 43868.0, 43951.340729889074, 39717.0, 40327.59672403297, 40400.59599404027, 40787.79606101951, 40840.387394189114, 7047.894281585678, 7239.963800180965, 7260.564366138048, 7326.4138868889295, 7330.853382932418, 30122.24694382658, 30584.694153058186, 30631.387372252877, 30935.535966960964, 31278.0, 35196.47205291974, 35214.0, 35925.461118083775, 37630.43554346632, 38957.41563876601, 7866.370690344873, 7880.724174653859, 7920.287174154354, 7996.840063198587, 8073.111957684532, 9449.716508504756, 9471.47906865129, 9565.0, 9692.51537423112, 9722.611095556098, 8372.623231954698, 8547.57262136903, 8603.182697643713, 8839.602217900081, 8938.50838203905, 8944.586564207677, 9048.864267036131, 9092.181703646704, 9282.62869485213, 9541.761455963657, 8859.60131794058, 8974.326925480746, 8986.011538730865, 9045.909540904508, 9124.0, 7203.855922881408, 7252.0, 7305.890411643936, 7418.434685303438, 7613.9238607613215, 7916.168802275678, 7988.241117093867, 8018.198180181935, 8047.074586422402, 8047.315978141689], "unit": "score", "name": "yui.html", "value": 5278.891115971199}], "name": "dromaeo_css", "value": 5968.770212666234}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 113.0, 113.0, 115.0, 124.0, 114.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.3}, {"lowerIsBetter": true, "replicates": [160.0, 129.0, 156.0, 170.0, 138.0, 162.0, 165.0, 129.0, 168.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 162.0, 171.0, 165.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [76.0, 85.0, 73.0, 75.0, 73.0, 74.0, 126.0, 73.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 132.0, 97.0, 97.0, 98.0, 140.0, 97.0, 98.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 111.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 71.0, 71.0, 70.0, 70.0, 70.0, 70.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 69.8}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 71.0, 67.0, 72.0, 68.0, 68.0, 67.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 84.0, 86.0, 84.0, 85.0, 84.0, 86.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 126.0, 125.0, 139.0, 125.0, 131.0, 132.0, 127.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.5}, {"lowerIsBetter": true, "replicates": [137.0, 154.0, 142.0, 149.0, 151.0, 140.0, 152.0, 151.0, 139.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 75.0, 71.0, 70.0, 73.0, 74.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1542.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [186.88095683049897], "unit": "score", "name": "DeltaBlue", "value": 353.79741800000016}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5291.005291005291], "unit": "score", "name": "Decrypt", "value": 50.30820900000001}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [710.7320540156361], "unit": "score", "name": "Earley", "value": 937.7134409999999}, {"lowerIsBetter": false, "replicates": [12469.135802469136], "unit": "score", "name": "Boyer", "value": 53.449012871287174}, {"lowerIsBetter": false, "replicates": [43382.97872340425], "unit": "score", "name": "RegExp", "value": 20.998673369298682}, {"lowerIsBetter": false, "replicates": [604.5949214026602], "unit": "score", "name": "Splay", "value": 134.78611399999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20215.05606206243}]} 08:01:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20215.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1542.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "5968.77"}}} 08:01:27 INFO - Return code: 0 08:01:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:01:27 INFO - # TBPL SUCCESS # 08:01:27 INFO - Running post-action listener: _resource_record_post_action 08:01:27 INFO - Running post-run listener: _resource_record_post_run 08:01:29 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 381464576; Read time: 0; Write time: 260280 08:01:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 74133504; Read time: 0; Write time: 34036 08:01:29 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 307331072; Read time: 0; Write time: 226244 08:01:29 INFO - Running post-run listener: _upload_blobber_files 08:01:29 INFO - Blob upload gear active. 08:01:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:29 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 08:01:29 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'] 08:01:29 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 08:01:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:01:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:30 INFO - (blobuploader) - INFO - Done attempting. 08:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:31 INFO - (blobuploader) - INFO - Done attempting. 08:01:31 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:31 INFO - Return code: 0 08:01:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/25a057c80cd00afb894033ebc0fa4de76a7f66a28e2c74c12c9e7af6981e510f6879a3d5727c74675cd02348f9648ab0a61d4e10cc74c4b61d421cc309e7c026", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fd9b29d536e9628bc2c16bedff8ddea595e42dea68147f6f37955b017278335705093dcee4e45a4578d6e0367cefd639d4c8c9bed976fcbd8b28bf5bb0f20f"} 08:01:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:31 INFO - Contents: 08:01:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/25a057c80cd00afb894033ebc0fa4de76a7f66a28e2c74c12c9e7af6981e510f6879a3d5727c74675cd02348f9648ab0a61d4e10cc74c4b61d421cc309e7c026", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fd9b29d536e9628bc2c16bedff8ddea595e42dea68147f6f37955b017278335705093dcee4e45a4578d6e0367cefd639d4c8c9bed976fcbd8b28bf5bb0f20f"} 08:01:31 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:31 INFO - Copying logs to upload dir... 08:01:31 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1298.420467 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-01-15 08:01:31.478343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 08:01:31.481393) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 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/25a057c80cd00afb894033ebc0fa4de76a7f66a28e2c74c12c9e7af6981e510f6879a3d5727c74675cd02348f9648ab0a61d4e10cc74c4b61d421cc309e7c026", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fd9b29d536e9628bc2c16bedff8ddea595e42dea68147f6f37955b017278335705093dcee4e45a4578d6e0367cefd639d4c8c9bed976fcbd8b28bf5bb0f20f"} build_url:https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/YvlWrnsAQ6eZ6c1dmoJ5gQ/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/25a057c80cd00afb894033ebc0fa4de76a7f66a28e2c74c12c9e7af6981e510f6879a3d5727c74675cd02348f9648ab0a61d4e10cc74c4b61d421cc309e7c026", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35fd9b29d536e9628bc2c16bedff8ddea595e42dea68147f6f37955b017278335705093dcee4e45a4578d6e0367cefd639d4c8c9bed976fcbd8b28bf5bb0f20f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 08:01:31.506715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 08:01:31.510094) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1452871138.727643-203540349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002891 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 08:01:31.556814) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 08:01:31.557138) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 08:01:31.557426) ========= ========= Total master_lag: 0.41 =========