builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1451456909.06 results: success (0) buildid: 20151229215139 builduid: 7dc77199cbeb4c7287884a11d3f67470 revision: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.056595) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.057045) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.057457) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006382 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.096684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.096981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.162246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.162519) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.218810) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.219127) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.219474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.219765) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 22:28:29-- 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% 47.2M=0s 2015-12-29 22:28:29 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.393826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.394264) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022468 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.446255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:29.446709) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77420c71e0d49620c056cbd4a74cb1e41a891ac5 --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 77420c71e0d49620c056cbd4a74cb1e41a891ac5 --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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 22:28:29,751 truncating revision to first 12 chars 2015-12-29 22:28:29,751 Setting DEBUG logging. 2015-12-29 22:28:29,751 attempt 1/10 2015-12-29 22:28:29,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77420c71e0d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 22:28:30,087 unpacking tar archive at: fx-team-77420c71e0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:30.074109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:30.074425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:30.085193) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:30.085461) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:30.085832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-29 22:28:30.086106) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:28:30 INFO - MultiFileLogger online at 20151229 22:28:30 in /builds/slave/test 22:28:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:28:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:28:30 INFO - {'append_to_log': False, 22:28:30 INFO - 'base_work_dir': '/builds/slave/test', 22:28:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:28:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:28:30 INFO - 'branch': 'Fx-Team-Non-PGO', 22:28:30 INFO - 'buildbot_json_path': 'buildprops.json', 22:28:30 INFO - 'config_files': ('talos/linux_config.py',), 22:28:30 INFO - 'default_actions': ('clobber', 22:28:30 INFO - 'read-buildbot-config', 22:28:30 INFO - 'download-and-extract', 22:28:30 INFO - 'populate-webroot', 22:28:30 INFO - 'create-virtualenv', 22:28:30 INFO - 'install', 22:28:30 INFO - 'run-tests'), 22:28:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:28:30 INFO - 'download_minidump_stackwalk': True, 22:28:30 INFO - 'download_symbols': 'ondemand', 22:28:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:28:30 INFO - 'tooltool.py': '/tools/tooltool.py', 22:28:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:28:30 INFO - '/tools/misc-python/virtualenv.py')}, 22:28:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:28:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:28:30 INFO - 'installer_path': 'installer.exe', 22:28:30 INFO - 'log_level': 'info', 22:28:30 INFO - 'log_name': 'talos', 22:28:30 INFO - 'log_to_console': True, 22:28:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:28:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:28:30 INFO - 'opt_config_files': (), 22:28:30 INFO - 'pip_index': False, 22:28:30 INFO - 'sps_profile': False, 22:28:30 INFO - 'sps_profile_interval': 0, 22:28:30 INFO - 'suite': 'dromaeojs', 22:28:30 INFO - 'system_bits': '32', 22:28:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:28:30 INFO - 'title': 'talos-linux64-ix-015', 22:28:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:28:30 INFO - 'use_talos_json': True, 22:28:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:28:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:28:30 INFO - 'work_dir': 'build'} 22:28:30 INFO - ##### 22:28:30 INFO - ##### Running clobber step. 22:28:30 INFO - ##### 22:28:30 INFO - Running pre-action listener: _resource_record_pre_action 22:28:30 INFO - Running main action method: clobber 22:28:30 INFO - rmtree: /builds/slave/test/build 22:28:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:28:31 INFO - Running post-action listener: _resource_record_post_action 22:28:31 INFO - ##### 22:28:31 INFO - ##### Running read-buildbot-config step. 22:28:31 INFO - ##### 22:28:31 INFO - Running pre-action listener: _resource_record_pre_action 22:28:31 INFO - Running main action method: read_buildbot_config 22:28:31 INFO - Using buildbot properties: 22:28:31 INFO - { 22:28:31 INFO - "project": "", 22:28:31 INFO - "product": "firefox", 22:28:31 INFO - "script_repo_revision": "production", 22:28:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:28:31 INFO - "repository": "", 22:28:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:28:31 INFO - "buildid": "20151229215139", 22:28:31 INFO - "pgo_build": "False", 22:28:31 INFO - "basedir": "/builds/slave/test", 22:28:31 INFO - "buildnumber": 1056, 22:28:31 INFO - "slavename": "talos-linux64-ix-015", 22:28:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:28:31 INFO - "platform": "ubuntu64_hw", 22:28:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:28:31 INFO - "branch": "fx-team", 22:28:31 INFO - "repo_path": "integration/fx-team", 22:28:31 INFO - "revision": "77420c71e0d49620c056cbd4a74cb1e41a891ac5", 22:28:31 INFO - "stage_platform": "linux64", 22:28:31 INFO - "builduid": "7dc77199cbeb4c7287884a11d3f67470", 22:28:31 INFO - "slavebuilddir": "test" 22:28:31 INFO - } 22:28:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:28:31 INFO - Running post-action listener: _resource_record_post_action 22:28:31 INFO - ##### 22:28:31 INFO - ##### Running download-and-extract step. 22:28:31 INFO - ##### 22:28:31 INFO - Running pre-action listener: _resource_record_pre_action 22:28:31 INFO - Running main action method: download_and_extract 22:28:31 INFO - mkdir: /builds/slave/test/build/tests 22:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:31 INFO - https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:28:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/test_packages.json 22:28:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/test_packages.json 22:28:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:28:37 INFO - Downloaded 1302 bytes. 22:28:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:28:37 INFO - Using the following test package requirements: 22:28:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:28:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:37 INFO - u'jsshell-linux-x86_64.zip'], 22:28:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:28:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:28:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:28:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:28:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:28:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:37 INFO - https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:28:39 INFO - Downloaded 21943114 bytes. 22:28:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:28:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:28:40 INFO - Return code: 0 22:28:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:40 INFO - https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:28:49 INFO - Downloaded 21943114 bytes. 22:28:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:28:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:28:50 INFO - Return code: 0 22:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:50 INFO - https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:28:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:28:51 INFO - Downloaded 11132285 bytes. 22:28:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 22:28:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:28:51 INFO - Return code: 0 22:28: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')]} 22:28:51 INFO - https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:28:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:28:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:28:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:28:53 INFO - Downloaded 53321834 bytes. 22:28:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:28:53 INFO - mkdir: /builds/slave/test/properties 22:28:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:28:53 INFO - Writing to file /builds/slave/test/properties/build_url 22:28:53 INFO - Contents: 22:28:53 INFO - build_url:https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:28:53 INFO - Running post-action listener: _resource_record_post_action 22:28:53 INFO - Running post-action listener: set_extra_try_arguments 22:28:53 INFO - ##### 22:28:53 INFO - ##### Running populate-webroot step. 22:28:53 INFO - ##### 22:28:53 INFO - Running pre-action listener: _resource_record_pre_action 22:28:53 INFO - Running main action method: populate_webroot 22:28:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:28:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:28:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:28:53 INFO - '--tppagecycles', 22:28:53 INFO - '7'], 22:28:53 INFO - 'tests': ['tsvgm']}}, 22:28:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:28:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:28:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:28:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:28:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'tests': ['damp', 'tps']}, 22:28:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['damp', 'tps']}, 22:28:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:28:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:28:53 INFO - 'other': {'tests': ['a11yr', 22:28:53 INFO - 'ts_paint', 22:28:53 INFO - 'tpaint', 22:28:53 INFO - 'sessionrestore', 22:28:53 INFO - 'sessionrestore_no_auto_restore']}, 22:28:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['a11yr', 22:28:53 INFO - 'ts_paint', 22:28:53 INFO - 'tpaint', 22:28:53 INFO - 'sessionrestore', 22:28:53 INFO - 'sessionrestore_no_auto_restore']}, 22:28:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['a11yr', 22:28:53 INFO - 'ts_paint', 22:28:53 INFO - 'tpaint', 22:28:53 INFO - 'sessionrestore', 22:28:53 INFO - 'sessionrestore_no_auto_restore']}, 22:28:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['a11yr', 22:28:53 INFO - 'ts_paint', 22:28:53 INFO - 'tpaint', 22:28:53 INFO - 'sessionrestore', 22:28:53 INFO - 'sessionrestore_no_auto_restore']}, 22:28:53 INFO - 'other_l64': {'tests': ['a11yr', 22:28:53 INFO - 'ts_paint', 22:28:53 INFO - 'tpaint', 22:28:53 INFO - 'sessionrestore', 22:28:53 INFO - 'sessionrestore_no_auto_restore']}, 22:28:53 INFO - 'other_nol64': {'tests': ['a11yr', 22:28:53 INFO - 'ts_paint', 22:28:53 INFO - 'tpaint', 22:28:53 INFO - 'sessionrestore', 22:28:53 INFO - 'sessionrestore_no_auto_restore']}, 22:28:53 INFO - 'svgr': {'tests': ['tsvgx', 22:28:53 INFO - 'tsvgr_opacity', 22:28:53 INFO - 'tart', 22:28:53 INFO - 'tscrollx', 22:28:53 INFO - 'cart']}, 22:28:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['tsvgx', 22:28:53 INFO - 'tsvgr_opacity', 22:28:53 INFO - 'tart', 22:28:53 INFO - 'tscrollx', 22:28:53 INFO - 'cart']}, 22:28:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'tests': ['tp5o']}, 22:28:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'talos_options': ['--e10s'], 22:28:53 INFO - 'tests': ['tp5o']}, 22:28:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'talos_options': ['--xperf_path', 22:28:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:53 INFO - 'tests': ['tp5n']}, 22:28:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:53 INFO - 'talos_options': ['--e10s', 22:28:53 INFO - '--xperf_path', 22:28:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:53 INFO - 'tests': ['tp5n']}}, 22:28:53 INFO - 'talos.zip': {'path': '', 22:28:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:28:53 INFO - Running post-action listener: _resource_record_post_action 22:28:53 INFO - ##### 22:28:53 INFO - ##### Running create-virtualenv step. 22:28:53 INFO - ##### 22:28:53 INFO - Running pre-action listener: _resource_record_pre_action 22:28:53 INFO - Running main action method: create_virtualenv 22:28:53 INFO - Creating virtualenv /builds/slave/test/build/venv 22:28:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:28:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:28:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:28:53 INFO - Using real prefix '/usr' 22:28:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:28:53 INFO - Installing distribute.............................................................................................................................................................................................done. 22:28:55 INFO - Installing pip.................done. 22:28:55 INFO - Return code: 0 22:28:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:55 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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:28:55 INFO - Using env: {'DISPLAY': ':0', 22:28:55 INFO - 'HOME': '/home/cltbld', 22:28:55 INFO - 'LANG': 'en_US.UTF-8', 22:28:55 INFO - 'LANGUAGE': 'en_US:en', 22:28:55 INFO - 'LOGNAME': 'cltbld', 22:28:55 INFO - 'MAIL': '/var/mail/cltbld', 22:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:55 INFO - 'MOZ_NO_REMOTE': '1', 22:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:55 INFO - 'NO_EM_RESTART': '1', 22:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:55 INFO - 'PWD': '/builds/slave/test', 22:28:55 INFO - 'SHELL': '/bin/bash', 22:28:55 INFO - 'SHLVL': '1', 22:28:55 INFO - 'TERM': 'linux', 22:28:55 INFO - 'TMOUT': '86400', 22:28:55 INFO - 'USER': 'cltbld', 22:28:55 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:55 INFO - '_': '/tools/buildbot/bin/python'} 22:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:28:55 INFO - Cleaning up... 22:28:55 INFO - Return code: 0 22:28:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:55 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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:28:55 INFO - Using env: {'DISPLAY': ':0', 22:28:55 INFO - 'HOME': '/home/cltbld', 22:28:55 INFO - 'LANG': 'en_US.UTF-8', 22:28:55 INFO - 'LANGUAGE': 'en_US:en', 22:28:55 INFO - 'LOGNAME': 'cltbld', 22:28:55 INFO - 'MAIL': '/var/mail/cltbld', 22:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:55 INFO - 'MOZ_NO_REMOTE': '1', 22:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:55 INFO - 'NO_EM_RESTART': '1', 22:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:55 INFO - 'PWD': '/builds/slave/test', 22:28:55 INFO - 'SHELL': '/bin/bash', 22:28:55 INFO - 'SHLVL': '1', 22:28:55 INFO - 'TERM': 'linux', 22:28:55 INFO - 'TMOUT': '86400', 22:28:55 INFO - 'USER': 'cltbld', 22:28:55 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:55 INFO - '_': '/tools/buildbot/bin/python'} 22:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:56 INFO - Downloading/unpacking psutil>=0.7.1 22:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:28:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:28:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:57 INFO - Installing collected packages: psutil 22:28:57 INFO - Running setup.py install for psutil 22:28:57 INFO - building 'psutil._psutil_linux' extension 22:28:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:28:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:28:58 INFO - building 'psutil._psutil_posix' extension 22:28:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:28:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:28:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:58 INFO - Successfully installed psutil 22:28:58 INFO - Cleaning up... 22:28:58 INFO - Return code: 0 22:28:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:28:58 INFO - Using env: {'DISPLAY': ':0', 22:28:58 INFO - 'HOME': '/home/cltbld', 22:28:58 INFO - 'LANG': 'en_US.UTF-8', 22:28:58 INFO - 'LANGUAGE': 'en_US:en', 22:28:58 INFO - 'LOGNAME': 'cltbld', 22:28:58 INFO - 'MAIL': '/var/mail/cltbld', 22:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:58 INFO - 'MOZ_NO_REMOTE': '1', 22:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:58 INFO - 'NO_EM_RESTART': '1', 22:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:58 INFO - 'PWD': '/builds/slave/test', 22:28:58 INFO - 'SHELL': '/bin/bash', 22:28:58 INFO - 'SHLVL': '1', 22:28:58 INFO - 'TERM': 'linux', 22:28:58 INFO - 'TMOUT': '86400', 22:28:58 INFO - 'USER': 'cltbld', 22:28:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:58 INFO - '_': '/tools/buildbot/bin/python'} 22:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:29:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:29:00 INFO - Installing collected packages: mozsystemmonitor 22:29:00 INFO - Running setup.py install for mozsystemmonitor 22:29:00 INFO - Successfully installed mozsystemmonitor 22:29:00 INFO - Cleaning up... 22:29:00 INFO - Return code: 0 22:29:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:29: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')]} 22:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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')]} 22:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:00 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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:29:00 INFO - Using env: {'DISPLAY': ':0', 22:29:00 INFO - 'HOME': '/home/cltbld', 22:29:00 INFO - 'LANG': 'en_US.UTF-8', 22:29:00 INFO - 'LANGUAGE': 'en_US:en', 22:29:00 INFO - 'LOGNAME': 'cltbld', 22:29:00 INFO - 'MAIL': '/var/mail/cltbld', 22:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:00 INFO - 'MOZ_NO_REMOTE': '1', 22:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:00 INFO - 'NO_EM_RESTART': '1', 22:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:00 INFO - 'PWD': '/builds/slave/test', 22:29:00 INFO - 'SHELL': '/bin/bash', 22:29:00 INFO - 'SHLVL': '1', 22:29:00 INFO - 'TERM': 'linux', 22:29:00 INFO - 'TMOUT': '86400', 22:29:00 INFO - 'USER': 'cltbld', 22:29:00 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:00 INFO - '_': '/tools/buildbot/bin/python'} 22:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:00 INFO - Downloading/unpacking blobuploader==1.2.4 22:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:02 INFO - Downloading blobuploader-1.2.4.tar.gz 22:29:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:29:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:29:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:03 INFO - Downloading docopt-0.6.1.tar.gz 22:29:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:29:03 INFO - Installing collected packages: blobuploader, requests, docopt 22:29:03 INFO - Running setup.py install for blobuploader 22:29:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:29:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:29:03 INFO - Running setup.py install for requests 22:29:03 INFO - Running setup.py install for docopt 22:29:03 INFO - Successfully installed blobuploader requests docopt 22:29:03 INFO - Cleaning up... 22:29:03 INFO - Return code: 0 22:29:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:03 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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:29:03 INFO - Using env: {'DISPLAY': ':0', 22:29:03 INFO - 'HOME': '/home/cltbld', 22:29:03 INFO - 'LANG': 'en_US.UTF-8', 22:29:03 INFO - 'LANGUAGE': 'en_US:en', 22:29:03 INFO - 'LOGNAME': 'cltbld', 22:29:03 INFO - 'MAIL': '/var/mail/cltbld', 22:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:03 INFO - 'MOZ_NO_REMOTE': '1', 22:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:03 INFO - 'NO_EM_RESTART': '1', 22:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:03 INFO - 'PWD': '/builds/slave/test', 22:29:03 INFO - 'SHELL': '/bin/bash', 22:29:03 INFO - 'SHLVL': '1', 22:29:03 INFO - 'TERM': 'linux', 22:29:03 INFO - 'TMOUT': '86400', 22:29:03 INFO - 'USER': 'cltbld', 22:29:03 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:03 INFO - '_': '/tools/buildbot/bin/python'} 22:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:29:03 INFO - Running setup.py (path:/tmp/pip-CehiMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:29:04 INFO - Running setup.py (path:/tmp/pip-TgFaSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:29:04 INFO - Running setup.py (path:/tmp/pip-Rkou2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:29:04 INFO - Running setup.py (path:/tmp/pip-tzEeGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:29:04 INFO - Running setup.py (path:/tmp/pip-qY37xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:29:04 INFO - Running setup.py (path:/tmp/pip-KI9EnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:29:04 INFO - Running setup.py (path:/tmp/pip-OjH3hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:29:04 INFO - Running setup.py (path:/tmp/pip-Aqo_YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:29:04 INFO - Running setup.py (path:/tmp/pip-E0qz1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:29:04 INFO - Running setup.py (path:/tmp/pip-dSt0WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:29:04 INFO - Running setup.py (path:/tmp/pip-tQZ9it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:29:04 INFO - Running setup.py (path:/tmp/pip-n5S_7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:29:04 INFO - Running setup.py (path:/tmp/pip-ceKHl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:29:04 INFO - Running setup.py (path:/tmp/pip-D0Bx3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:04 INFO - Running setup.py (path:/tmp/pip-cfmryl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:29:05 INFO - Running setup.py (path:/tmp/pip-6hLZIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:29:05 INFO - Running setup.py (path:/tmp/pip-gezabv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:29:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:29:05 INFO - Running setup.py install for manifestparser 22:29:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Running setup.py install for mozcrash 22:29:05 INFO - Running setup.py install for mozdebug 22:29:05 INFO - Running setup.py install for mozdevice 22:29:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Running setup.py install for mozfile 22:29:05 INFO - Running setup.py install for mozhttpd 22:29:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Running setup.py install for mozinfo 22:29:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Running setup.py install for mozInstall 22:29:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:29:05 INFO - Running setup.py install for mozleak 22:29:06 INFO - Running setup.py install for mozlog 22:29:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:29:06 INFO - Running setup.py install for moznetwork 22:29:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:29:06 INFO - Running setup.py install for mozprocess 22:29:06 INFO - Running setup.py install for mozprofile 22:29:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:29:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:29:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:29:06 INFO - Running setup.py install for mozrunner 22:29:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:29:06 INFO - Running setup.py install for mozscreenshot 22:29:06 INFO - Running setup.py install for moztest 22:29:06 INFO - Running setup.py install for mozversion 22:29:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:29:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:29:06 INFO - Cleaning up... 22:29:06 INFO - Return code: 0 22:29:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:06 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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:29:06 INFO - Using env: {'DISPLAY': ':0', 22:29:06 INFO - 'HOME': '/home/cltbld', 22:29:06 INFO - 'LANG': 'en_US.UTF-8', 22:29:06 INFO - 'LANGUAGE': 'en_US:en', 22:29:06 INFO - 'LOGNAME': 'cltbld', 22:29:06 INFO - 'MAIL': '/var/mail/cltbld', 22:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:06 INFO - 'MOZ_NO_REMOTE': '1', 22:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:06 INFO - 'NO_EM_RESTART': '1', 22:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:06 INFO - 'PWD': '/builds/slave/test', 22:29:06 INFO - 'SHELL': '/bin/bash', 22:29:06 INFO - 'SHLVL': '1', 22:29:06 INFO - 'TERM': 'linux', 22:29:06 INFO - 'TMOUT': '86400', 22:29:06 INFO - 'USER': 'cltbld', 22:29:06 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:06 INFO - '_': '/tools/buildbot/bin/python'} 22:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:29:07 INFO - Running setup.py (path:/tmp/pip-XwU4gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:29:07 INFO - Running setup.py (path:/tmp/pip-uy3UKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:29:07 INFO - Running setup.py (path:/tmp/pip-58CmaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:29:07 INFO - Running setup.py (path:/tmp/pip-DC0aTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:29:07 INFO - Running setup.py (path:/tmp/pip-MxWos4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:29:07 INFO - Running setup.py (path:/tmp/pip-I8SBhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:29:07 INFO - Running setup.py (path:/tmp/pip-67bZXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:29:07 INFO - Running setup.py (path:/tmp/pip-LYIh31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:29:07 INFO - Running setup.py (path:/tmp/pip-nsSCps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:29:07 INFO - Running setup.py (path:/tmp/pip-NvsBcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:29:07 INFO - Running setup.py (path:/tmp/pip-pBPSK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:29:08 INFO - Running setup.py (path:/tmp/pip-aT9BR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:29:08 INFO - Running setup.py (path:/tmp/pip-_WeWjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:29:08 INFO - Running setup.py (path:/tmp/pip-NJWB5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:08 INFO - Running setup.py (path:/tmp/pip-kDG7cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:29:08 INFO - Running setup.py (path:/tmp/pip-ou2Cq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:29:08 INFO - Running setup.py (path:/tmp/pip-ak0AhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:29:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:10 INFO - Downloading blessings-1.5.1.tar.gz 22:29:10 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:29:10 INFO - Installing collected packages: blessings 22:29:10 INFO - Running setup.py install for blessings 22:29:10 INFO - Successfully installed blessings 22:29:10 INFO - Cleaning up... 22:29:10 INFO - Return code: 0 22:29:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:29:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:29:10 INFO - Reading from file tmpfile_stdout 22:29:10 INFO - Current package versions: 22:29:10 INFO - argparse == 1.2.1 22:29:10 INFO - blessings == 1.5.1 22:29:10 INFO - blobuploader == 1.2.4 22:29:10 INFO - docopt == 0.6.1 22:29:10 INFO - manifestparser == 1.1 22:29:10 INFO - mozInstall == 1.12 22:29:10 INFO - mozcrash == 0.16 22:29:10 INFO - mozdebug == 0.1 22:29:10 INFO - mozdevice == 0.47 22:29:10 INFO - mozfile == 1.2 22:29:10 INFO - mozhttpd == 0.7 22:29:10 INFO - mozinfo == 0.9 22:29:10 INFO - mozleak == 0.1 22:29:10 INFO - mozlog == 3.1 22:29:10 INFO - moznetwork == 0.27 22:29:10 INFO - mozprocess == 0.22 22:29:10 INFO - mozprofile == 0.28 22:29:10 INFO - mozrunner == 6.11 22:29:10 INFO - mozscreenshot == 0.1 22:29:10 INFO - mozsystemmonitor == 0.0 22:29:10 INFO - moztest == 0.7 22:29:10 INFO - mozversion == 1.4 22:29:10 INFO - psutil == 3.1.1 22:29:10 INFO - requests == 1.2.3 22:29:10 INFO - wsgiref == 0.1.2 22:29:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:29:10 INFO - Using env: {'DISPLAY': ':0', 22:29:10 INFO - 'HOME': '/home/cltbld', 22:29:10 INFO - 'LANG': 'en_US.UTF-8', 22:29:10 INFO - 'LANGUAGE': 'en_US:en', 22:29:10 INFO - 'LOGNAME': 'cltbld', 22:29:10 INFO - 'MAIL': '/var/mail/cltbld', 22:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:10 INFO - 'MOZ_NO_REMOTE': '1', 22:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:10 INFO - 'NO_EM_RESTART': '1', 22:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:10 INFO - 'PWD': '/builds/slave/test', 22:29:10 INFO - 'SHELL': '/bin/bash', 22:29:10 INFO - 'SHLVL': '1', 22:29:10 INFO - 'TERM': 'linux', 22:29:10 INFO - 'TMOUT': '86400', 22:29:10 INFO - 'USER': 'cltbld', 22:29:10 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:10 INFO - '_': '/tools/buildbot/bin/python'} 22:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:29:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:29:10 INFO - Cleaning up... 22:29:10 INFO - Return code: 0 22:29:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:29:10 INFO - Using env: {'DISPLAY': ':0', 22:29:10 INFO - 'HOME': '/home/cltbld', 22:29:10 INFO - 'LANG': 'en_US.UTF-8', 22:29:10 INFO - 'LANGUAGE': 'en_US:en', 22:29:10 INFO - 'LOGNAME': 'cltbld', 22:29:10 INFO - 'MAIL': '/var/mail/cltbld', 22:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:10 INFO - 'MOZ_NO_REMOTE': '1', 22:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:10 INFO - 'NO_EM_RESTART': '1', 22:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:10 INFO - 'PWD': '/builds/slave/test', 22:29:10 INFO - 'SHELL': '/bin/bash', 22:29:10 INFO - 'SHLVL': '1', 22:29:10 INFO - 'TERM': 'linux', 22:29:10 INFO - 'TMOUT': '86400', 22:29:10 INFO - 'USER': 'cltbld', 22:29:10 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:10 INFO - '_': '/tools/buildbot/bin/python'} 22:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:10 INFO - Downloading/unpacking jsonschema 22:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:29:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:29:12 INFO - Downloading/unpacking functools32 (from jsonschema) 22:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:29:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:29:12 INFO - warning: no files found matching '*.txt' 22:29:12 INFO - no previously-included directories found matching 'build' 22:29:12 INFO - no previously-included directories found matching 'dist' 22:29:12 INFO - no previously-included directories found matching '.git*' 22:29:12 INFO - Installing collected packages: jsonschema, functools32 22:29:12 INFO - Running setup.py install for functools32 22:29:13 INFO - warning: no files found matching '*.txt' 22:29:13 INFO - no previously-included directories found matching 'build' 22:29:13 INFO - no previously-included directories found matching 'dist' 22:29:13 INFO - no previously-included directories found matching '.git*' 22:29:13 INFO - Successfully installed jsonschema functools32 22:29:13 INFO - Cleaning up... 22:29:13 INFO - Return code: 0 22:29:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:13 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 0x7f5004510f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c03dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, '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': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:29:13 INFO - Using env: {'DISPLAY': ':0', 22:29:13 INFO - 'HOME': '/home/cltbld', 22:29:13 INFO - 'LANG': 'en_US.UTF-8', 22:29:13 INFO - 'LANGUAGE': 'en_US:en', 22:29:13 INFO - 'LOGNAME': 'cltbld', 22:29:13 INFO - 'MAIL': '/var/mail/cltbld', 22:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:13 INFO - 'MOZ_NO_REMOTE': '1', 22:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:13 INFO - 'NO_EM_RESTART': '1', 22:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:13 INFO - 'PWD': '/builds/slave/test', 22:29:13 INFO - 'SHELL': '/bin/bash', 22:29:13 INFO - 'SHLVL': '1', 22:29:13 INFO - 'TERM': 'linux', 22:29:13 INFO - 'TMOUT': '86400', 22:29:13 INFO - 'USER': 'cltbld', 22:29:13 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:13 INFO - '_': '/tools/buildbot/bin/python'} 22:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:13 INFO - Downloading/unpacking flake8 22:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:29:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:29:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:29:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:29:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:29:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:29:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:29:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:29:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:29:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:29:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:29:15 INFO - no previously-included directories found matching 'docs/_build' 22:29:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:29:15 INFO - Running setup.py install for pep8 22:29:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:29:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:29:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:29:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:29:15 INFO - no previously-included directories found matching 'docs/_build' 22:29:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:29:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:29:15 INFO - Cleaning up... 22:29:15 INFO - Return code: 0 22:29:15 INFO - Running post-action listener: _resource_record_post_action 22:29:15 INFO - Running post-action listener: _start_resource_monitoring 22:29:15 INFO - Starting resource monitoring. 22:29:15 INFO - ##### 22:29:15 INFO - ##### Running install step. 22:29:15 INFO - ##### 22:29:15 INFO - Running pre-action listener: _resource_record_pre_action 22:29:15 INFO - Running main action method: install 22:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:29:16 INFO - Reading from file tmpfile_stdout 22:29:16 INFO - Detecting whether we're running mozinstall >=1.0... 22:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:29:16 INFO - Reading from file tmpfile_stdout 22:29:16 INFO - Output received: 22:29:16 INFO - Usage: mozinstall [options] installer 22:29:16 INFO - Options: 22:29:16 INFO - -h, --help show this help message and exit 22:29:16 INFO - -d DEST, --destination=DEST 22:29:16 INFO - Directory to install application into. [default: 22:29:16 INFO - "/builds/slave/test"] 22:29:16 INFO - --app=APP Application being installed. [default: firefox] 22:29:16 INFO - mkdir: /builds/slave/test/build/application 22:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:29:31 INFO - Reading from file tmpfile_stdout 22:29:31 INFO - Output received: 22:29:31 INFO - /builds/slave/test/build/application/firefox/firefox 22:29:31 INFO - Running post-action listener: _resource_record_post_action 22:29:31 INFO - ##### 22:29:31 INFO - ##### Running run-tests step. 22:29:31 INFO - ##### 22:29:31 INFO - Running pre-action listener: _resource_record_pre_action 22:29:31 INFO - Running main action method: run_tests 22:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:29:31 INFO - Python 2.7.3 22:29:31 INFO - Return code: 0 22:29:31 INFO - grabbing minidump binary from tooltool 22:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c963d0>, '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 0x2c01ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c02360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:29:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:29:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:29:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:29:31 INFO - Return code: 0 22:29:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:29:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:29:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:29:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:29:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:29:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:29:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:29:32 INFO - Return code: 0 22:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:29:32 INFO - Using env: {'DISPLAY': ':0', 22:29:32 INFO - 'HOME': '/home/cltbld', 22:29:32 INFO - 'LANG': 'en_US.UTF-8', 22:29:32 INFO - 'LANGUAGE': 'en_US:en', 22:29:32 INFO - 'LOGNAME': 'cltbld', 22:29:32 INFO - 'MAIL': '/var/mail/cltbld', 22:29:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:29:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:32 INFO - 'MOZ_NO_REMOTE': '1', 22:29:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:32 INFO - 'NO_EM_RESTART': '1', 22:29:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:32 INFO - 'PWD': '/builds/slave/test', 22:29:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:29:32 INFO - 'SHELL': '/bin/bash', 22:29:32 INFO - 'SHLVL': '1', 22:29:32 INFO - 'TERM': 'linux', 22:29:32 INFO - 'TMOUT': '86400', 22:29:32 INFO - 'USER': 'cltbld', 22:29:32 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639', 22:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:32 INFO - '_': '/tools/buildbot/bin/python'} 22:29:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:29:33 INFO - mozversion application_buildid: 20151229215139 22:29:33 INFO - mozversion application_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 22:29:33 INFO - mozversion application_display_name: Nightly 22:29:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:29:33 INFO - mozversion application_name: Firefox 22:29:33 INFO - mozversion application_remotingname: firefox 22:29:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:29:33 INFO - mozversion application_vendor: Mozilla 22:29:33 INFO - mozversion application_version: 46.0a1 22:29:33 INFO - mozversion platform_buildid: 20151229215139 22:29:33 INFO - mozversion platform_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 22:29:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:29:33 INFO - mozversion platform_version: 46.0a1 22:29:33 INFO - using testdate: 1451456973 22:29:33 INFO - actual date: 1451456973 22:29:33 INFO - starting webserver on 'localhost:47569' 22:29:33 INFO - SUITE-START | Running 3 tests 22:29:33 INFO - TEST-START | dromaeo_css 22:29:33 INFO - operating with platform_type : linux_ 22:29:33 INFO - Initialising browser for dromaeo_css test... 22:29:33 INFO - TEST-INFO | started process 22375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5_2_Qy/profile http://localhost:47569/getInfo.html) 22:29:37 INFO - PROCESS | 22375 | __metrics Screen width/height:1600/1200 22:29:37 INFO - PROCESS | 22375 | colorDepth:24 22:29:37 INFO - PROCESS | 22375 | Browser inner width/height: 1024/697 22:29:37 INFO - PROCESS | 22375 | __metrics 22:29:37 INFO - PROCESS | 22375 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:29:38 INFO - PROCESS | 22375 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:29:38 INFO - TEST-INFO | 22375: exit 0 22:29:38 INFO - Browser initialized. 22:29:38 INFO - Running cycle 1/1 for dromaeo_css test... 22:29:38 INFO - TEST-INFO | started process 22469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5_2_Qy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:29:50 INFO - PROCESS | 22469 | RSS: Main: 148934656 22:29:50 INFO - PROCESS | 22469 | 22:30:42 INFO - PROCESS | 22469 | 1451457042058 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:32:54 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:47569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47569/tests/dromaeo/cssquery-ext.html) 22:32:55 INFO - PROCESS | 22469 | RSS: Main: 276979712 22:32:55 INFO - PROCESS | 22469 | 22:35:57 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:47569/tests/dromaeo/cssquery-ext.html (next: http://localhost:47569/tests/dromaeo/cssquery-jquery.html) 22:35:58 INFO - PROCESS | 22469 | RSS: Main: 232701952 22:35:58 INFO - PROCESS | 22469 | 22:39:00 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:47569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47569/tests/dromaeo/cssquery-mootools.html) 22:39:01 INFO - PROCESS | 22469 | RSS: Main: 228671488 22:39:01 INFO - PROCESS | 22469 | 22:42:03 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:47569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47569/tests/dromaeo/cssquery-prototype.html) 22:42:03 INFO - PROCESS | 22469 | RSS: Main: 214196224 22:42:03 INFO - PROCESS | 22469 | 22:45:06 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:47569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47569/tests/dromaeo/cssquery-yui.html) 22:45:07 INFO - PROCESS | 22469 | RSS: Main: 217235456 22:45:07 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | Cycle 1(1): loaded http://localhost:47569/tests/dromaeo/cssquery-yui.html (next: http://localhost:47569/tests/dromaeo/cssquery-dojo.html) 22:48:09 INFO - PROCESS | 22469 | RSS: Main: 268513280 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | __start_tp_report 22:48:09 INFO - PROCESS | 22469 | _x_x_mozilla_page_load 22:48:09 INFO - PROCESS | 22469 | _x_x_mozilla_page_load_details 22:48:09 INFO - PROCESS | 22469 | |i|pagename|runs| 22:48:09 INFO - PROCESS | 22469 | |0;dojo.html;2593.935151621209;2682.0344675916667;2695.070200780732;2695.6091366751807;2720.8775605097767;4429.13631841791;4544.79548420321;4570.337301091344;4573.176828170928;4580.862574122773;4595.678302518825;4614.5616166464215;4709.2229782085915;4714.717116972984;4732.077244937239;4219.873403797891;4237.110206856564;4303.203907277148;4362.19299429605;4385.188740083079;4301.354796780477;4345.630621397185;4373.606375426211;4381.78091095444;4411.823527058914;4076.4700588923547;4187.958120418787;4193.91612167758;4226.260404429213;4337.089211265638;4279.679024073207;4286.185624731291;4296.0548679290505;4305.20353734557;4330.631896288819;4211.8627970448115;4233.809478573472;4249.936250956238;4253.2769429197115;4295.72077814941;4399.5160532341415;4511.503734589192;4529.705569137996;4533.52397998212;4591.931121033187;4823.614110871122;4831.323614693911;4945.554900059012;5040.59675225981;5078.111330517182;4982.900341993176;5021.623378246646;5023.899522009539;5030.949690503085;5075.898482030376;4479.865604031885;4643.88390290242;4658.976705116521;4660.37084993525;4666.4633567139535;5006.824761133343;5032.672876263105;5034.320366750515;5118.10433174193;5121.923171152435;4880.438749543848;4884.291777692286;4891.070696567641;4892.951070489321;4924.9507504925205;4810.807567697323;4977.776000080005;4988.5260900214425;4996.025774973845;5027.949720502821;4809.0862736080035;4811.855644330676;4836.443808962014;4962.106820772224;5012.949870501321;4880.41435027799;4901.191303434894;4904.681195722266;4915;4953.108440480676;4163.292240319153;4187.623113919762;4200.012996945716;4203.894902627398;4244.681648876347;3583.283343331344;3626.147855254066;3659.432787917877;3677;3712.276106159273;4316.697831151852;4322.070754787673;4327;4359.738415695068;4372.475302963601;4997.7251251180805;4997.825076122318;4998.500149985045;5021.924671129936;5047.242913562922;4143.585641435892;4250.787460626956;4252.723572967747;4279.079997800488;4326.870193894189;4472;4485.41689580359;4492.168948744493;4498.910021799611;4500.369948207253;4750.5249475052215;4758.4765675776325;4763.666543342002;4773.236282194902;4810.95189048112;4828.396450443694;5010.323606313101;5014.84955451337;5053.343065401475;5059.772310245974;4651.627869770478;4666.8133274668635;4673.369095172108;4697.812087516461;4807.326974223542;4919.901601968012;4950;4952.603791696583;4953.950460495493;5002.774875130555;4993.176125939324;5018.121828679893;5018.322526459027;5024.095662780588;5063.696178229171;4628.352030715635;4708.646851486221;4783.497732738012;4784.976075119741;4853.708777473363;4866.148424025852;4866.683665561727;4883.95116048835;4886.780094895667;4915;4733.242681170997;4776.832810851603;4780.091782561302;4785.521447855187;4828.5412885775795;4725.1967165581245;4840.709557426566;4850.05423942342;4956.033573453142;4969.950300496948;4673.112108699336;4757.833475828329;4832.936753914133;4833.10587541306;4875.512448755097 22:48:09 INFO - PROCESS | 22469 | |1;ext.html;507.7461269365317;514.6371807875448;521.1453216724573;536.833581589707;538.1416640458467;24765;25463.23610291692;32370.190745231383;33137;33168.66831331686;36031.279374412494;36485;36506.26987460249;36538;36538.634613653856;6820.215675197342;7579.54522728638;7746.535207887545;7746.683063879126;7746.883796743025;6936.514443988923;9942.801143977116;10035.548400321966;10077.949610251939;10184.796304073914;9530.285228607847;9617.42295462271;9619;9619.951900240523;9633.277504187214;7005.229424763272;7156.463265255126;9822.165115965152;9954.601815927354;9978.700638980843;9657.855132173023;9829.361091529028;9844.556994935245;9855.556499957447;9855.55649995752;32132;32554;32638.83680581582;32758.6724132758;32811.6718832811;2639.934001649955;3197.936041279185;3342.7827191232736;3350.64818194091;3375.966240337614;25380.238592842245;27491;27613.86193069022;27730.445391092064;27994.720052799414;3165.683431656839;3202.087405089562;3231;3233.4018206631613;3256.951145732816;168312;168630;169116.15441922835;169202;169314.99999999878;45767.77116114465;46630.533694663296;53246;53348.73325633347;53574.196387054224;52295.21557176646;52401.7379913098;52537.47462525326;52572.21141682878;52642.73678631582;11603.709907252387;11633.53465861373;11636.301821890713;11677.532898683958;11791.764164716658;7640.350570201484;7641.961790191013;7647.502912310682;7650.655720492591;7762.495437796638;17738.29046838138;18000.549986250448;18015.63968720618;18030.639387212446;18207.453776386465;6942.479314051467;7104.147502299757;7163.964180179066;7236.312550307713;7292.270772922665;717.2863001313726;836.0093289452019;839.5927974932154;967.2938754709102;973.3819024919227;26018.6097208542;26096.086636967615;26915.86542067277;27241;27252;881.1628952495155;891.7503099132254;946.1673727120091;991.5820376861013;1013.0123129948241;12685.619431417072;12864;13167.736645267041;13254.469821207043;13293.734125317633;262027;262203;264532;267112;267683;44091.77954110209;44245.11509769787;44300;44449.33326000113;44614.33078503825;1117.5027112934665;1164.2839653613137;1169.6724917023248;1171.7480741640588;1173.2901594535183;21454.463638409165;24187.879060604584;24641.137560185307;26121.216363509124;27160.407789414934;38609.42085868658;38970;39019.804900975316;39028.219435611696;39030;196539;198804;198870;199917;199930;24497.877510612332;24991.625125623494;28648.14055578336;29923.850380748827;30999.690003100583;35109;35320.29359412849;35791.28417431585;36008.639913601575;36014.27971440504;30451.086467406014;30470.847645762515;30491.2377190572;31027.53458698076;31490;31354.843225783727;31435.214119647193;31494.37011259716;31649.20876978094;31784;30023.69976300209;30822;30900.60947257334;30926.690733092382;30938.845305773328;26427.60358594661;28032.859835700692;28035.43929121447;28060.29849253785;28108.71891281143;22138.33584992453;22147.55704885861;22279.888600556893;22467.88766056159;22484.77515224827 22:48:09 INFO - PROCESS | 22469 | |2;jquery.html;341.5627996164909;344.0813029212005;344.3216862780322;345.24736075355713;345.944648856183;12482.25106493611;12880.549180778675;14872.702545949089;14906.254687265635;15791.368345266175;12655.93672031641;14518.637034074154;15135.24323783812;15575.143367114804;15583.532494025168;4778.331033655282;4914.410270767513;4918.213085906255;4918.385201849769;4919.581835543983;3695.2978934002454;3826.043489127718;4849.781759820817;4883.389576302962;4892.315075889378;5511.724413779295;5648.661080335193;5657.8585535361535;5681.857953551153;5689.203511508392;5495.230667706504;5640.407757185498;5640.633358831663;5684.175794509814;5696.231008813798;5003.724795136266;5005.974970125126;5015.874603134915;5020.523050310215;5021.472745361721;17579.824201757947;18288.359907403177;18344.53243740511;19633.705494417594;19669.60660786776;1655.188957410872;1743.076169630098;1758.9384371547062;1811.7372980917826;1933.709943508485;12980;13093.47626094955;13131;13219.405126769318;13251.536196233086;1597.241310377573;1686.308613468472;1719.5443207550009;1843.4285371534734;1864.9440516784518;54388;57851.421485785024;59173.40826591722;59416.70291648557;60718;15170.24148792556;15248.3900643973;15252.313645885963;15258.847411525965;15280.923595381952;22783.88608056949;22826;22945.77054229436;22961.770382296298;23102.191423300104;7952.562609056557;8031.116577176506;8042.517448953082;8100.635471403801;8128.146544612849;5849.415058494202;5859.091840764689;5876.206712093898;5911.970440147772;5950.494207992283;7374.778756637309;7453.807390817443;7528.736494222676;7532.736354227576;7685.615719214017;1741.1033317841323;2165.8917054147228;2949.351142748592;2963.392504536608;2970;359.12552933606753;362.3984186250811;813.9104698483162;954.2938225712923;957.6935380678116;9254.76863078415;9406.153446189739;9432.481213533321;9617.749692539925;9676.12914837668;362.0947630922693;387.0555843741262;387.59302732131147;396.0791160551671;397.48525659271314;5047.268146118866;5074.11203039474;5082.33929589151;5091.3126727892;5209;534448;552636;562327;562975;574855;56634.58413539612;62331.68834155891;63177;66951;70923.2907670927;1004.1113614451117;1022.9232807539464;1027.7841653252751;1032.0814475117152;1043.9060484556273;13884.375203115682;14135.010549261864;14842.851571484147;14932.02941808779;14938.626534336294;22801.973911173704;29047.854760726063;29857;30613.54079688762;31038.068857934297;39478;40240.19519609533;40647.59352406557;41243.1751364977;42267.36598950957;8653.913460865311;9056.36605437613;9372.765680858032;9404.670836520689;9407.529623518934;16030.358785648443;16092;16344.182790860172;16590.83409165893;16799.244034018255;13364.398602062736;13473.258970756311;13533.458661653423;14188.858111419167;14320.856791431952;13107;13650.863491364958;13703.383347749175;13721.382537786023;14223.431062757374;10535.852062022388;12528.87471125277;13908.791368129689;13971.790423143864;14575.635609109857;8106.513609183467;8396.664133434595;8450.408471406943;8479.703210387606;8962.058983806866;9070.954645226731;9324.627014919328;9326.626934922528;11216.327020378803;14449.060811047248 22:48:09 INFO - PROCESS | 22469 | |3;mootools.html;1213.939303034848;1371.3897315694517;1393.010962216826;1488.4567132996453;1719.6560687862432;6143.692815359231;6737.461003119751;6842.589444633326;6941.479389045817;6945.479089068315;6999.23008469068;7142.321479459456;7221.061262035928;7223.4221262299025;7234.421246300297;2073.3676228750264;2119.2900378373265;2121.448423409917;2121.6075026120216;2122.734658167729;2102.295730930133;2126.7873212678687;2150.623640862843;2165.17723265159;2174.836887233456;2070.3167954574956;2073.6785798201304;2080.8127268545904;2105.631514484967;2106.6208082545136;2079.8128168464837;2096;2109.2617583845686;2109.641360968639;2109.947251318714;2068.700038494425;2102.6530622447276;2109.8101170894693;2113.3131732187103;2114.0381126587367;7122;7191.35277824993;7193.856122877513;7199.1001124859395;7202.4238060954995;4203.7057405981595;4234.745915245096;4269.530351661346;4281.079567892918;4283.271843786564;2679.6650418697664;2688.4354285600048;2715.8777854996574;2729.7952653550865;2733.425980544088;808.8180159464132;856.5503110866782;856.9228769410782;857.1471385970937;892.4600616626977;9307.34848560601;9327.580258888298;9330.953345233298;9367.297452691075;9379.953100234523;3833.5783063862955;3844.1735026969336;3899.74651647642;3933.2920074386884;3933.7246392752804;8155.429119961665;8190.959045204736;8191.180881911761;8194.713185038614;8195.631196596167;4245.57544245573;4255.936160957588;4280.6789490788315;4282.272013757669;4286.099919016979;3320.701136897691;3395.864165433404;3726.5900750917376;3846.788426636562;3869.941950870739;3351.564296641421;3384.1539615096226;3399.745019123526;3414.641462646436;3438.3123375325035;1068.759529105945;1085.7448499602588;1086.983695244572;1095.2333366643381;1098.2861140258735;863.1842908451453;869.0787764969153;872.2237208884098;876.071364353787;914.6432891172448;6795.150606174228;6860.211075726255;6861.588304701734;6877.346652068046;6882.827929301708;1000.8999100089933;1009.6970908727352;1012.5949620151998;1019.56158851693;1033.0650761061252;4795.976020119947;4813.205821039559;4821.252705830531;4825.179719447702;4825.662203645781;8264.793380165544;8460.153984601613;8657.696980605648;8669.133086691407;8724.69463568772;8173.713920012771;8178.754637360769;8280.254777070093;8359.665613375397;8387.412881098386;6739;6779.3220677932795;6782.016607591871;6805.625690586966;6816.931830681729;6361.904571431525;6520.054592084027;6535.5425120241125;6549.705263263069;6551.050097735897;7546.735864244725;7690.577018263825;7726.613669316399;7898.407619428681;7956.801079973047;7836.09884863248;8014.198580142172;8089.514629122272;8111.351091912515;8123.47197432165;5498;5594.356648985418;6334.524910631629;6386.16979792624;6414.5189110815945;6413.583117097373;6446.677666116581;6507.934920650733;6528.543001990005;6532.967335163294;6118.174046503665;6244.250689917239;6311.27420346666;6347.143135676809;6512.804615861532;6174.536909731878;6242.188515492957;6256.092866534418;6331.715072821642;6350.206224221973;6202.193714817045;6214.751409943732;6230.06549017651;6350.809475715736;6367.267764207176;6014.097885317237;6024.90962635552;6042.486388657014;6047.455728984412;6052.303985041776;5944.73248703818;6030.276366836008;6048;6055.909161362495;6056.9091463628965 22:48:09 INFO - PROCESS | 22469 | |4;prototype.html;299.19367305112723;309.06815949911015;309.4260147426524;323.1356122372654;326.85781684967054;5185.325907632007;5287.233351164084;5308.548773354265;5388.407275199725;5441.918371224435;5251.369835619731;5308.946910530894;5320.14877619581;5330.786768529254;5340.599455040868;3923.1761330120707;4009.9198016039663;4015.3575427931537;4131.297679394495;4132.814023368941;4085.305498065336;4092.631663150316;4093.2427500912427;4101.774402407867;4146.751194928314;4096.283150448675;4096.918061638766;4098.118904435546;4100.979495102535;4106.733062350952;3884.844606215748;3973.1656352166224;3980.20395920817;4049;4055.797210139481;3559.110222444389;3585.318789430026;3591.6947059499976;3596.892093237207;3602.2975519773654;5017.523335283142;5019.498050194988;5029.2958985742025;5031.723255220962;5043.773030213649;4710.505396933341;4715.1512727709;4715.198416269242;4723.07899959508;4725;5439.619226654136;5552.77788888444;5557.166425036277;5568.136938774496;5570.526505247059;3905.9218815623813;3917.9216415671813;3918.0792513759243;3919.2357490289405;3924.50943632046;5767.625104368202;5859.1797148399255;5862.794802181903;5868.647881127146;5869.647821130746;4035.0315924177985;4038.7172897897453;4044.6359827615065;4044.8584299549375;4045.959540404617;3982.8406863725704;4083.9387409188885;4097.91804163921;4099.426080348753;4109.650679692199;4652.976735116303;4658.231391820379;4663;4665.533446655375;4671.602913752369;5539.390667026624;5540.418256083134;5540.778368865281;5543.805966791143;5545.417731138173;1410.4146779086564;1432.3053319140208;1434.7560914644534;1435.5119259451628;1436.5259464376938;943.6036864516919;957.3920560444029;965.0976337124811;994.9452780097164;997.8203923293731;4911.950880491221;4916.06594746997;4924.630652701062;4931.580815630711;4939.753012349368;5749;5749.88500229993;5750.108733146285;5752.194692743019;5754.88490230193;4914.803407863646;4920.138975679241;4921.212605983025;4923.335349727812;4923.433805112458;2882.6973167817496;2976.791624586258;3061.112277439562;3080.6919308069014;3107.6426210985574;5513.448655134454;5547.417521160301;5549.278593782782;5549.417311182348;5554.611177217636;5920.911186332209;5926.7925622603;5932.2584676915385;5944.7324870380935;5975.940240597538;5535.474129957647;5537.861553461195;5542.889142217214;5543.974364742536;5552.8056518023295;5602.915956260578;5753.2520772301;5768.336641286306;5816.76732930678;5854.443827836349;5694.800681976111;5696.658200507983;5698.629589076697;5700.743466543932;5703.429657034263;5538.030844602259;5541.196526503554;5545.279113715191;5546.889062218653;5558.972205138948;3900.1419687668667;4017.9598204017584;4051.6961227908614;4054.655354294918;4055.3916912463364;5769;5774.94225057744;5777.826665200051;5782.161586570008;5789.681567513827;5574.303212098488;5617.4101719320515;5618.494335509824;5629.099344104923;5629.605927585029;5528.612997090165;5529.30883639545;5531;5533.418991006048;5538.889222215614;5295.205719142159;5415.214793854948;5423.430539793423;5427.972860135674;5435.429279925551;5587.217789509553;5598.664080155204;5605.495505404533;5610.242617246619;5624.859378515406;5247.291615631841;5332.920006199833;5403.675779453245;5523.475269849358;5530.695811730394 22:48:09 INFO - PROCESS | 22469 | |5;yui.html;744.601638123604;746.775967209837;749.3742724824771;757.2692351880435;760.410681721666;11281.210315277924;11394.25937314074;11402.201845870772;11426.600068997586;11433.485493152808;10798.622048228313;10979.61571345003;11161;11170.776584468305;11183.83224251637;765.9655315510815;782.5500337306044;782.8825676148595;783.0720596093619;783.8471498057881;770.3336613829053;776.6621519638946;777.7627823513826;778.2723153851167;778.3967425245452;799.1808396393685;808.7169490678245;810.1533897077568;810.5177419435427;810.5825499867543;797.0435477427081;799.1050023973158;801.9879701804477;803.1687203744156;805.6334367862609;599.7660912244228;600.2586805295457;600.7026521871658;600.906859436788;601.0203368509345;11478.598249061326;11604.361760103191;11626.825597616042;11627.244229125165;11678.182527223098;10964.232503724743;11047.779044419147;11052.115830733523;11057.557697692082;11411.828822567668;8939.508327042011;8954.149355811187;8960.23837973773;9052.502112383816;9071.682491112779;3206.8075915445147;3227.0964130043626;3242.270489139948;3265.8367081645824;3285.3593549257666;32846;33088.83455582731;35840.283194336225;36564.81717591395;36648;9342.019087995663;9359.391639543408;9632.90367096334;9697.6605818796;9786.266030047775;15234.77147842761;15275.694486110215;15352.232388380537;15362.155081470626;15385.922900408525;6185.072239164161;6251.12484252205;6274.215723034621;6375.808725738235;6496.252930912911;3026.1980575147604;3310.9404990403323;3350.463925771865;3373.9493907591404;3448.9655103448645;2943.632045994251;2967.4806908790874;2974.1226338230276;2974.7174018468645;2976.940461190764;517.7721802406929;518.7561845932406;520.7162096657331;521.0382908350065;525.8080800507787;394.7631421147346;427.4016377072062;479.37441638661187;490.4898905138687;508.9058524172984;6681.231658359254;6903.447724182053;7037.964810175917;7048.647567621599;7642.273983971514;407.8083300848656;502.8491452564216;513.2942204468856;527.4593541619794;531.7181893596401;2885.653721553427;3055.358374741285;3165.9525107123413;3245.221146924721;3267.166872447558;47536.04927901422;47634.285485717744;47940;47956.28065579019;47974.28038579424;41871.37192942108;41939.37090943638;42054.36918446226;42059.7897010513;42134.57865421368;34761.65238347584;34850.30299393998;44074.33888491675;45699.08601827945;46254.53745462569;6944.027836102849;7253.3834624057545;7258.528195667264;7353.742619008309;7604.695812167673;29021.419571608873;29294.26764330909;29900.401991959603;30368.392632147676;30439.695603043685;36742.26515469729;38023.42964855474;38188.236235274584;38842.805785970886;38874.80562597169;9785.951070244602;10063.647772327933;10134;10203;10353.378797272188;11070.667879963614;11313.377764223047;11319;11466.31202127875;12101.818472723093;9108.635654573744;9177.128172823572;9352.953235234052;9585.281103917094;9625.855612165684;9763.365381250196;9766.36518626287;10057.245706572183;10453.372797632166;10650.627228046982;9045.412048216846;9207.217386521952;9207.58565864551;9299.953500232456;9319.30105242096;9435.150836424755;9613.663521776703;9859;9977.251706121924;10208.489575521342;8054.315383192495;8416.537090459839;8438.957805211181;8454.619542120496;8623.310135189044 22:48:09 INFO - PROCESS | 22469 | __end_tp_report 22:48:09 INFO - PROCESS | 22469 | __start_cc_report 22:48:09 INFO - PROCESS | 22469 | _x_x_mozilla_cycle_collect,1049 22:48:09 INFO - PROCESS | 22469 | __end_cc_report 22:48:09 INFO - PROCESS | 22469 | __startTimestamp1451458089803__endTimestamp 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | ------- Summary: start ------- 22:48:09 INFO - PROCESS | 22469 | Number of tests: 6 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | [#0] dojo.html Cycles:165 Average:4593.81 Median:4732.08 stddev:475.42 (10.0%) stddev-sans-first:450.25 22:48:09 INFO - PROCESS | 22469 | Values: 2593.9 2682.0 2695.1 2695.6 2720.9 4429.1 4544.8 4570.3 4573.2 4580.9 4595.7 4614.6 4709.2 4714.7 4732.1 4219.9 4237.1 4303.2 4362.2 4385.2 4301.4 4345.6 4373.6 4381.8 4411.8 4076.5 4188.0 4193.9 4226.3 4337.1 4279.7 4286.2 4296.1 4305.2 4330.6 4211.9 4233.8 4249.9 4253.3 4295.7 4399.5 4511.5 4529.7 4533.5 4591.9 4823.6 4831.3 4945.6 5040.6 5078.1 4982.9 5021.6 5023.9 5030.9 5075.9 4479.9 4643.9 4659.0 4660.4 4666.5 5006.8 5032.7 5034.3 5118.1 5121.9 4880.4 4884.3 4891.1 4893.0 4925.0 4810.8 4977.8 4988.5 4996.0 5027.9 4809.1 4811.9 4836.4 4962.1 5012.9 4880.4 4901.2 4904.7 4915.0 4953.1 4163.3 4187.6 4200.0 4203.9 4244.7 3583.3 3626.1 3659.4 3677.0 3712.3 4316.7 4322.1 4327.0 4359.7 4372.5 4997.7 4997.8 4998.5 5021.9 5047.2 4143.6 4250.8 4252.7 4279.1 4326.9 4472.0 4485.4 4492.2 4498.9 4500.4 4750.5 4758.5 4763.7 4773.2 4811.0 4828.4 5010.3 5014.8 5053.3 5059.8 4651.6 4666.8 4673.4 4697.8 4807.3 4919.9 4950.0 4952.6 4954.0 5002.8 4993.2 5018.1 5018.3 5024.1 5063.7 4628.4 4708.6 4783.5 4785.0 4853.7 4866.1 4866.7 4884.0 4886.8 4915.0 4733.2 4776.8 4780.1 4785.5 4828.5 4725.2 4840.7 4850.1 4956.0 4970.0 4673.1 4757.8 4832.9 4833.1 4875.5 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | [#1] ext.html Cycles:180 Average:36535.90 Median:17681.50 stddev:55840.10 (315.8%) stddev-sans-first:55931.22 22:48:09 INFO - PROCESS | 22469 | Values: 507.7 514.6 521.1 536.8 538.1 24765.0 25463.2 32370.2 33137.0 33168.7 36031.3 36485.0 36506.3 36538.0 36538.6 6820.2 7579.5 7746.5 7746.7 7746.9 6936.5 9942.8 10035.5 10077.9 10184.8 9530.3 9617.4 9619.0 9620.0 9633.3 7005.2 7156.5 9822.2 9954.6 9978.7 9657.9 9829.4 9844.6 9855.6 9855.6 32132.0 32554.0 32638.8 32758.7 32811.7 2639.9 3197.9 3342.8 3350.6 3376.0 25380.2 27491.0 27613.9 27730.4 27994.7 3165.7 3202.1 3231.0 3233.4 3257.0 168312.0 168630.0 169116.2 169202.0 169315.0 45767.8 46630.5 53246.0 53348.7 53574.2 52295.2 52401.7 52537.5 52572.2 52642.7 11603.7 11633.5 11636.3 11677.5 11791.8 7640.4 7642.0 7647.5 7650.7 7762.5 17738.3 18000.5 18015.6 18030.6 18207.5 6942.5 7104.1 7164.0 7236.3 7292.3 717.3 836.0 839.6 967.3 973.4 26018.6 26096.1 26915.9 27241.0 27252.0 881.2 891.8 946.2 991.6 1013.0 12685.6 12864.0 13167.7 13254.5 13293.7 262027.0 262203.0 264532.0 267112.0 267683.0 44091.8 44245.1 44300.0 44449.3 44614.3 1117.5 1164.3 1169.7 1171.7 1173.3 21454.5 24187.9 24641.1 26121.2 27160.4 38609.4 38970.0 39019.8 39028.2 39030.0 196539.0 198804.0 198870.0 199917.0 199930.0 24497.9 24991.6 28648.1 29923.9 30999.7 35109.0 35320.3 35791.3 36008.6 36014.3 30451.1 30470.8 30491.2 31027.5 31490.0 31354.8 31435.2 31494.4 31649.2 31784.0 30023.7 30822.0 30900.6 30926.7 30938.8 26427.6 28032.9 28035.4 28060.3 28108.7 22138.3 22147.6 22279.9 22467.9 22484.8 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | [#2] jquery.html Cycles:180 Average:28279.73 Median:3760.67 stddev:90865.46 (2416.2%) stddev-sans-first:91096.14 22:48:09 INFO - PROCESS | 22469 | Values: 341.6 344.1 344.3 345.2 345.9 12482.3 12880.5 14872.7 14906.3 15791.4 12655.9 14518.6 15135.2 15575.1 15583.5 4778.3 4914.4 4918.2 4918.4 4919.6 3695.3 3826.0 4849.8 4883.4 4892.3 5511.7 5648.7 5657.9 5681.9 5689.2 5495.2 5640.4 5640.6 5684.2 5696.2 5003.7 5006.0 5015.9 5020.5 5021.5 17579.8 18288.4 18344.5 19633.7 19669.6 1655.2 1743.1 1758.9 1811.7 1933.7 12980.0 13093.5 13131.0 13219.4 13251.5 1597.2 1686.3 1719.5 1843.4 1864.9 54388.0 57851.4 59173.4 59416.7 60718.0 15170.2 15248.4 15252.3 15258.8 15280.9 22783.9 22826.0 22945.8 22961.8 23102.2 7952.6 8031.1 8042.5 8100.6 8128.1 5849.4 5859.1 5876.2 5912.0 5950.5 7374.8 7453.8 7528.7 7532.7 7685.6 1741.1 2165.9 2949.4 2963.4 2970.0 359.1 362.4 813.9 954.3 957.7 9254.8 9406.2 9432.5 9617.7 9676.1 362.1 387.1 387.6 396.1 397.5 5047.3 5074.1 5082.3 5091.3 5209.0 534448.0 552636.0 562327.0 562975.0 574855.0 56634.6 62331.7 63177.0 66951.0 70923.3 1004.1 1022.9 1027.8 1032.1 1043.9 13884.4 14135.0 14842.9 14932.0 14938.6 22802.0 29047.9 29857.0 30613.5 31038.1 39478.0 40240.2 40647.6 41243.2 42267.4 8653.9 9056.4 9372.8 9404.7 9407.5 16030.4 16092.0 16344.2 16590.8 16799.2 13364.4 13473.3 13533.5 14188.9 14320.9 13107.0 13650.9 13703.4 13721.4 14223.4 10535.9 12528.9 13908.8 13971.8 14575.6 8106.5 8396.7 8450.4 8479.7 8962.1 9071.0 9324.6 9326.6 11216.3 14449.1 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | [#3] mootools.html Cycles:180 Average:4933.41 Median:6208.47 stddev:2551.61 (41.1%) stddev-sans-first:2543.45 22:48:09 INFO - PROCESS | 22469 | Values: 1213.9 1371.4 1393.0 1488.5 1719.7 6143.7 6737.5 6842.6 6941.5 6945.5 6999.2 7142.3 7221.1 7223.4 7234.4 2073.4 2119.3 2121.4 2121.6 2122.7 2102.3 2126.8 2150.6 2165.2 2174.8 2070.3 2073.7 2080.8 2105.6 2106.6 2079.8 2096.0 2109.3 2109.6 2109.9 2068.7 2102.7 2109.8 2113.3 2114.0 7122.0 7191.4 7193.9 7199.1 7202.4 4203.7 4234.7 4269.5 4281.1 4283.3 2679.7 2688.4 2715.9 2729.8 2733.4 808.8 856.6 856.9 857.1 892.5 9307.3 9327.6 9331.0 9367.3 9380.0 3833.6 3844.2 3899.7 3933.3 3933.7 8155.4 8191.0 8191.2 8194.7 8195.6 4245.6 4255.9 4280.7 4282.3 4286.1 3320.7 3395.9 3726.6 3846.8 3869.9 3351.6 3384.2 3399.7 3414.6 3438.3 1068.8 1085.7 1087.0 1095.2 1098.3 863.2 869.1 872.2 876.1 914.6 6795.2 6860.2 6861.6 6877.3 6882.8 1000.9 1009.7 1012.6 1019.6 1033.1 4796.0 4813.2 4821.3 4825.2 4825.7 8264.8 8460.2 8657.7 8669.1 8724.7 8173.7 8178.8 8280.3 8359.7 8387.4 6739.0 6779.3 6782.0 6805.6 6816.9 6361.9 6520.1 6535.5 6549.7 6551.1 7546.7 7690.6 7726.6 7898.4 7956.8 7836.1 8014.2 8089.5 8111.4 8123.5 5498.0 5594.4 6334.5 6386.2 6414.5 6413.6 6446.7 6507.9 6528.5 6533.0 6118.2 6244.3 6311.3 6347.1 6512.8 6174.5 6242.2 6256.1 6331.7 6350.2 6202.2 6214.8 6230.1 6350.8 6367.3 6014.1 6024.9 6042.5 6047.5 6052.3 5944.7 6030.3 6048.0 6055.9 6056.9 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | [#4] prototype.html Cycles:180 Average:4626.06 Median:5308.75 stddev:1361.92 (25.7%) stddev-sans-first:1326.45 22:48:09 INFO - PROCESS | 22469 | Values: 299.2 309.1 309.4 323.1 326.9 5185.3 5287.2 5308.5 5388.4 5441.9 5251.4 5308.9 5320.1 5330.8 5340.6 3923.2 4009.9 4015.4 4131.3 4132.8 4085.3 4092.6 4093.2 4101.8 4146.8 4096.3 4096.9 4098.1 4101.0 4106.7 3884.8 3973.2 3980.2 4049.0 4055.8 3559.1 3585.3 3591.7 3596.9 3602.3 5017.5 5019.5 5029.3 5031.7 5043.8 4710.5 4715.2 4715.2 4723.1 4725.0 5439.6 5552.8 5557.2 5568.1 5570.5 3905.9 3917.9 3918.1 3919.2 3924.5 5767.6 5859.2 5862.8 5868.6 5869.6 4035.0 4038.7 4044.6 4044.9 4046.0 3982.8 4083.9 4097.9 4099.4 4109.7 4653.0 4658.2 4663.0 4665.5 4671.6 5539.4 5540.4 5540.8 5543.8 5545.4 1410.4 1432.3 1434.8 1435.5 1436.5 943.6 957.4 965.1 994.9 997.8 4912.0 4916.1 4924.6 4931.6 4939.8 5749.0 5749.9 5750.1 5752.2 5754.9 4914.8 4920.1 4921.2 4923.3 4923.4 2882.7 2976.8 3061.1 3080.7 3107.6 5513.4 5547.4 5549.3 5549.4 5554.6 5920.9 5926.8 5932.3 5944.7 5975.9 5535.5 5537.9 5542.9 5544.0 5552.8 5602.9 5753.3 5768.3 5816.8 5854.4 5694.8 5696.7 5698.6 5700.7 5703.4 5538.0 5541.2 5545.3 5546.9 5559.0 3900.1 4018.0 4051.7 4054.7 4055.4 5769.0 5774.9 5777.8 5782.2 5789.7 5574.3 5617.4 5618.5 5629.1 5629.6 5528.6 5529.3 5531.0 5533.4 5538.9 5295.2 5415.2 5423.4 5428.0 5435.4 5587.2 5598.7 5605.5 5610.2 5624.9 5247.3 5332.9 5403.7 5523.5 5530.7 22:48:09 INFO - PROCESS | 22469 | 22:48:09 INFO - PROCESS | 22469 | [#5] yui.html Cycles:180 Average:11686.69 Median:47965.28 stddev:13164.51 (27.4%) stddev-sans-first:13175.79 22:48:09 INFO - PROCESS | 22469 | Values: 744.6 746.8 749.4 757.3 760.4 11281.2 11394.3 11402.2 11426.6 11433.5 10798.6 10979.6 11161.0 11170.8 11183.8 766.0 782.6 782.9 783.1 783.8 770.3 776.7 777.8 778.3 778.4 799.2 808.7 810.2 810.5 810.6 797.0 799.1 802.0 803.2 805.6 599.8 600.3 600.7 600.9 601.0 11478.6 11604.4 11626.8 11627.2 11678.2 10964.2 11047.8 11052.1 11057.6 11411.8 8939.5 8954.1 8960.2 9052.5 9071.7 3206.8 3227.1 3242.3 3265.8 3285.4 32846.0 33088.8 35840.3 36564.8 36648.0 9342.0 9359.4 9632.9 9697.7 9786.3 15234.8 15275.7 15352.2 15362.2 15385.9 6185.1 6251.1 6274.2 6375.8 6496.3 3026.2 3310.9 3350.5 3373.9 3449.0 2943.6 2967.5 2974.1 2974.7 2976.9 517.8 518.8 520.7 521.0 525.8 394.8 427.4 479.4 490.5 508.9 6681.2 6903.4 7038.0 7048.6 7642.3 407.8 502.8 513.3 527.5 531.7 2885.7 3055.4 3166.0 3245.2 3267.2 47536.0 47634.3 47940.0 47956.3 47974.3 41871.4 41939.4 42054.4 42059.8 42134.6 34761.7 34850.3 44074.3 45699.1 46254.5 6944.0 7253.4 7258.5 7353.7 7604.7 29021.4 29294.3 29900.4 30368.4 30439.7 36742.3 38023.4 38188.2 38842.8 38874.8 9786.0 10063.6 10134.0 10203.0 10353.4 11070.7 11313.4 11319.0 11466.3 12101.8 9108.6 9177.1 9353.0 9585.3 9625.9 9763.4 9766.4 10057.2 10453.4 10650.6 9045.4 9207.2 9207.6 9300.0 9319.3 9435.2 9613.7 9859.0 9977.3 10208.5 8054.3 8416.5 8439.0 8454.6 8623.3 22:48:09 INFO - PROCESS | 22469 | -------- Summary: end -------- 22:48:09 INFO - PROCESS | 22469 | 22:48:10 INFO - TEST-INFO | 22469: exit 0 22:48:10 INFO - TEST-OK | dromaeo_css | took 1117574ms 22:48:10 INFO - TEST-START | kraken 22:48:10 INFO - operating with platform_type : linux_ 22:48:10 INFO - Initialising browser for kraken test... 22:48:10 INFO - TEST-INFO | started process 22662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPN6yHB/profile http://localhost:47569/getInfo.html) 22:48:14 INFO - PROCESS | 22662 | __metrics Screen width/height:1600/1200 22:48:14 INFO - PROCESS | 22662 | colorDepth:24 22:48:14 INFO - PROCESS | 22662 | Browser inner width/height: 1024/697 22:48:14 INFO - PROCESS | 22662 | __metrics 22:48:14 INFO - PROCESS | 22662 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:48:15 INFO - PROCESS | 22662 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:48:16 INFO - TEST-INFO | 22662: exit 0 22:48:16 INFO - Browser initialized. 22:48:16 INFO - Running cycle 1/1 for kraken test... 22:48:16 INFO - TEST-INFO | started process 22741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPN6yHB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:28 INFO - PROCESS | 22741 | RSS: Main: 148967424 22:48:28 INFO - PROCESS | 22741 | 22:48:30 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47569/tests/kraken/driver.html?testName=audio-beat-detection) 22:48:31 INFO - PROCESS | 22741 | RSS: Main: 185638912 22:48:31 INFO - PROCESS | 22741 | 22:48:34 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47569/tests/kraken/driver.html?testName=audio-dft) 22:48:34 INFO - PROCESS | 22741 | RSS: Main: 176439296 22:48:34 INFO - PROCESS | 22741 | 22:48:37 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47569/tests/kraken/driver.html?testName=audio-fft) 22:48:38 INFO - PROCESS | 22741 | RSS: Main: 161026048 22:48:38 INFO - PROCESS | 22741 | 22:48:40 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47569/tests/kraken/driver.html?testName=audio-oscillator) 22:48:40 INFO - PROCESS | 22741 | RSS: Main: 163643392 22:48:40 INFO - PROCESS | 22741 | 22:48:43 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:48:43 INFO - PROCESS | 22741 | RSS: Main: 164724736 22:48:43 INFO - PROCESS | 22741 | 22:48:46 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47569/tests/kraken/driver.html?testName=imaging-darkroom) 22:48:47 INFO - PROCESS | 22741 | RSS: Main: 166268928 22:48:47 INFO - PROCESS | 22741 | 22:48:50 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47569/tests/kraken/driver.html?testName=imaging-desaturate) 22:48:51 INFO - PROCESS | 22741 | RSS: Main: 165371904 22:48:51 INFO - PROCESS | 22741 | 22:48:53 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47569/tests/kraken/driver.html?testName=json-parse-financial) 22:48:54 INFO - PROCESS | 22741 | RSS: Main: 165695488 22:48:54 INFO - PROCESS | 22741 | 22:48:56 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:48:56 INFO - PROCESS | 22741 | RSS: Main: 177324032 22:48:56 INFO - PROCESS | 22741 | 22:48:58 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:48:59 INFO - PROCESS | 22741 | RSS: Main: 175513600 22:48:59 INFO - PROCESS | 22741 | 22:49:01 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:49:02 INFO - PROCESS | 22741 | RSS: Main: 187363328 22:49:02 INFO - PROCESS | 22741 | 22:49:04 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:49:05 INFO - PROCESS | 22741 | RSS: Main: 190042112 22:49:05 INFO - PROCESS | 22741 | 22:49:07 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:49:08 INFO - PROCESS | 22741 | RSS: Main: 188735488 22:49:08 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | Cycle 1(1): loaded http://localhost:47569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47569/tests/kraken/driver.html?testName=ai-astar) 22:49:10 INFO - PROCESS | 22741 | RSS: Main: 247222272 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | __start_tp_report 22:49:10 INFO - PROCESS | 22741 | _x_x_mozilla_page_load 22:49:10 INFO - PROCESS | 22741 | _x_x_mozilla_page_load_details 22:49:10 INFO - PROCESS | 22741 | |i|pagename|runs| 22:49:10 INFO - PROCESS | 22741 | |0;ai-astar;111;113;107;112;113;116;103;112;113;102 22:49:10 INFO - PROCESS | 22741 | |1;audio-beat-detection;154;132;153;172;130;157;153;129;166;132 22:49:10 INFO - PROCESS | 22741 | |2;audio-dft;162;160;161;161;162;161;161;161;163;163 22:49:10 INFO - PROCESS | 22741 | |3;audio-fft;73;77;83;91;71;73;73;98;91;72 22:49:10 INFO - PROCESS | 22741 | |4;audio-oscillator;97;97;140;97;98;98;135;97;98;129 22:49:10 INFO - PROCESS | 22741 | |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;109;109 22:49:10 INFO - PROCESS | 22741 | |6;imaging-darkroom;147;146;147;146;147;146;146;146;146;146 22:49:10 INFO - PROCESS | 22741 | |7;imaging-desaturate;95;97;95;96;95;96;96;95;96;95 22:49:10 INFO - PROCESS | 22741 | |8;json-parse-financial;70;69;68;68;69;77;68;78;68;67 22:49:10 INFO - PROCESS | 22741 | |9;json-stringify-tinderbox;68;68;69;69;69;71;68;69;70;68 22:49:10 INFO - PROCESS | 22741 | |10;stanford-crypto-aes;85;84;101;93;85;84;84;93;94;86 22:49:10 INFO - PROCESS | 22741 | |11;stanford-crypto-ccm;128;127;121;121;118;125;139;130;119;128 22:49:10 INFO - PROCESS | 22741 | |12;stanford-crypto-pbkdf2;136;148;150;148;147;143;148;148;145;136 22:49:10 INFO - PROCESS | 22741 | |13;stanford-crypto-sha256-iterative;69;70;71;71;70;70;70;73;70;72 22:49:10 INFO - PROCESS | 22741 | __end_tp_report 22:49:10 INFO - PROCESS | 22741 | __start_cc_report 22:49:10 INFO - PROCESS | 22741 | _x_x_mozilla_cycle_collect,973 22:49:10 INFO - PROCESS | 22741 | __end_cc_report 22:49:10 INFO - PROCESS | 22741 | __startTimestamp1451458150356__endTimestamp 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | ------- Summary: start ------- 22:49:10 INFO - PROCESS | 22741 | Number of tests: 14 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.50 stddev:4.64 (4.1%) stddev-sans-first:4.91 22:49:10 INFO - PROCESS | 22741 | Values: 111.0 113.0 107.0 112.0 113.0 116.0 103.0 112.0 113.0 102.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:153.50 stddev:15.86 (10.3%) stddev-sans-first:16.66 22:49:10 INFO - PROCESS | 22741 | Values: 154.0 132.0 153.0 172.0 130.0 157.0 153.0 129.0 166.0 132.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 22:49:10 INFO - PROCESS | 22741 | Values: 162.0 160.0 161.0 161.0 162.0 161.0 161.0 161.0 163.0 163.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#3] audio-fft Cycles:10 Average:80.20 Median:80.00 stddev:9.86 (12.3%) stddev-sans-first:10.11 22:49:10 INFO - PROCESS | 22741 | Values: 73.0 77.0 83.0 91.0 71.0 73.0 73.0 98.0 91.0 72.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:97.00 stddev:18.18 (18.7%) stddev-sans-first:18.79 22:49:10 INFO - PROCESS | 22741 | Values: 97.0 97.0 140.0 97.0 98.0 98.0 135.0 97.0 98.0 129.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:49:10 INFO - PROCESS | 22741 | Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 22:49:10 INFO - PROCESS | 22741 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 22:49:10 INFO - PROCESS | 22741 | Values: 95.0 97.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:69.00 stddev:3.94 (5.7%) stddev-sans-first:4.18 22:49:10 INFO - PROCESS | 22741 | Values: 70.0 69.0 68.0 68.0 69.0 77.0 68.0 78.0 68.0 67.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 22:49:10 INFO - PROCESS | 22741 | Values: 68.0 68.0 69.0 69.0 69.0 71.0 68.0 69.0 70.0 68.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:85.50 stddev:5.93 (6.9%) stddev-sans-first:6.12 22:49:10 INFO - PROCESS | 22741 | Values: 85.0 84.0 101.0 93.0 85.0 84.0 84.0 93.0 94.0 86.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:127.50 stddev:6.29 (4.9%) stddev-sans-first:6.61 22:49:10 INFO - PROCESS | 22741 | Values: 128.0 127.0 121.0 121.0 118.0 125.0 139.0 130.0 119.0 128.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:148.00 stddev:5.07 (3.4%) stddev-sans-first:4.23 22:49:10 INFO - PROCESS | 22741 | Values: 136.0 148.0 150.0 148.0 147.0 143.0 148.0 148.0 145.0 136.0 22:49:10 INFO - PROCESS | 22741 | 22:49:10 INFO - PROCESS | 22741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.17 (1.7%) stddev-sans-first:1.09 22:49:10 INFO - PROCESS | 22741 | Values: 69.0 70.0 71.0 71.0 70.0 70.0 70.0 73.0 70.0 72.0 22:49:10 INFO - PROCESS | 22741 | -------- Summary: end -------- 22:49:10 INFO - PROCESS | 22741 | 22:49:11 INFO - TEST-INFO | 22741: exit 0 22:49:11 INFO - TEST-OK | kraken | took 60703ms 22:49:11 INFO - TEST-START | v8_7 22:49:11 INFO - operating with platform_type : linux_ 22:49:11 INFO - Initialising browser for v8_7 test... 22:49:11 INFO - TEST-INFO | started process 22994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ4Js5G/profile http://localhost:47569/getInfo.html) 22:49:15 INFO - PROCESS | 22994 | __metrics Screen width/height:1600/1200 22:49:15 INFO - PROCESS | 22994 | colorDepth:24 22:49:15 INFO - PROCESS | 22994 | Browser inner width/height: 1024/697 22:49:15 INFO - PROCESS | 22994 | __metrics 22:49:15 INFO - PROCESS | 22994 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:49:15 INFO - PROCESS | 22994 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:49:17 INFO - TEST-INFO | 22994: exit 0 22:49:17 INFO - Browser initialized. 22:49:17 INFO - Running cycle 1/1 for v8_7 test... 22:49:17 INFO - TEST-INFO | started process 23079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ4Js5G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:49:29 INFO - PROCESS | 23079 | RSS: Main: 149159936 22:49:29 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | Cycle 1(1): loaded http://localhost:47569/tests/v8_7/run.html (next: http://localhost:47569/tests/v8_7/run.html) 22:49:50 INFO - PROCESS | 23079 | RSS: Main: 449916928 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | __start_tp_report 22:49:50 INFO - PROCESS | 23079 | _x_x_mozilla_page_load 22:49:50 INFO - PROCESS | 23079 | _x_x_mozilla_page_load_details 22:49:50 INFO - PROCESS | 23079 | |i|pagename|runs| 22:49:50 INFO - PROCESS | 23079 | |0;Richards;167.64459346186086 22:49:50 INFO - PROCESS | 23079 | |1;DeltaBlue;188.07598269700958 22:49:50 INFO - PROCESS | 23079 | |2;Encrypt;282.80542986425337 22:49:50 INFO - PROCESS | 23079 | |3;Decrypt;5256.544502617801 22:49:50 INFO - PROCESS | 23079 | |4;RayTrace;1972.3865877712033 22:49:50 INFO - PROCESS | 23079 | |5;Earley;807.1025020177563 22:49:50 INFO - PROCESS | 23079 | |6;Boyer;12358.024691358025 22:49:50 INFO - PROCESS | 23079 | |7;RegExp;26179.48717948718 22:49:50 INFO - PROCESS | 23079 | |8;Splay;619.5786864931846 22:49:50 INFO - PROCESS | 23079 | |9;NavierStokes;4830.917874396136 22:49:50 INFO - PROCESS | 23079 | __end_tp_report 22:49:50 INFO - PROCESS | 23079 | __startTimestamp1451458190713__endTimestamp 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | ------- Summary: start ------- 22:49:50 INFO - PROCESS | 23079 | Number of tests: 10 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 167.6 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#1] DeltaBlue Cycles:1 Average:188.08 Median:188.08 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 188.1 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#2] Encrypt Cycles:1 Average:282.81 Median:282.81 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 282.8 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 5256.5 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 1972.4 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#5] Earley Cycles:1 Average:807.10 Median:807.10 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 807.1 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 12358.0 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 26179.5 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#8] Splay Cycles:1 Average:619.58 Median:619.58 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 619.6 22:49:50 INFO - PROCESS | 23079 | 22:49:50 INFO - PROCESS | 23079 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:49:50 INFO - PROCESS | 23079 | Values: 4830.9 22:49:50 INFO - PROCESS | 23079 | -------- Summary: end -------- 22:49:50 INFO - PROCESS | 23079 | 22:49:51 INFO - TEST-INFO | 23079: exit 0 22:49:51 INFO - TEST-OK | v8_7 | took 40297ms 22:49:51 INFO - SUITE-END | took 1218s 22:49:51 INFO - Completed test suite (00:20:18) 22:49:51 INFO - Working with test: dromaeo_css 22:49:51 INFO - Generating results file: dromaeo_css 22:49:51 INFO - Working with test: kraken 22:49:51 INFO - Generating results file: kraken 22:49:51 INFO - javascript benchmark 22:49:51 INFO - Working with test: v8_7 22:49:51 INFO - Generating results file: v8_7 22:49:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:49:51 INFO - process_Request line: dromaeo_css 6183.63 graph.html#tests=[[72,132,35]] 22:49:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:51 INFO - process_Request line: kraken 1528.50 graph.html#tests=[[232,132,35]] 22:49:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:51 INFO - process_Request line: v8_7 19657.63 graph.html#tests=[[230,132,35]] 22:49:51 INFO - RETURN: dromaeo_css: 6183.63 22:49:51 INFO - RETURN: kraken: 1528.50 22:49:51 INFO - RETURN: v8_7: 19657.63 22:49:51 INFO - javascript benchmark 22:49:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2593.935151621209, 2682.0344675916667, 2695.070200780732, 2695.6091366751807, 2720.8775605097767, 4429.13631841791, 4544.79548420321, 4570.337301091344, 4573.176828170928, 4580.862574122773, 4595.678302518825, 4614.5616166464215, 4709.2229782085915, 4714.717116972984, 4732.077244937239, 4219.873403797891, 4237.110206856564, 4303.203907277148, 4362.19299429605, 4385.188740083079, 4301.354796780477, 4345.630621397185, 4373.606375426211, 4381.78091095444, 4411.823527058914, 4076.4700588923547, 4187.958120418787, 4193.91612167758, 4226.260404429213, 4337.089211265638, 4279.679024073207, 4286.185624731291, 4296.0548679290505, 4305.20353734557, 4330.631896288819, 4211.8627970448115, 4233.809478573472, 4249.936250956238, 4253.2769429197115, 4295.72077814941, 4399.5160532341415, 4511.503734589192, 4529.705569137996, 4533.52397998212, 4591.931121033187, 4823.614110871122, 4831.323614693911, 4945.554900059012, 5040.59675225981, 5078.111330517182, 4982.900341993176, 5021.623378246646, 5023.899522009539, 5030.949690503085, 5075.898482030376, 4479.865604031885, 4643.88390290242, 4658.976705116521, 4660.37084993525, 4666.4633567139535, 5006.824761133343, 5032.672876263105, 5034.320366750515, 5118.10433174193, 5121.923171152435, 4880.438749543848, 4884.291777692286, 4891.070696567641, 4892.951070489321, 4924.9507504925205, 4810.807567697323, 4977.776000080005, 4988.5260900214425, 4996.025774973845, 5027.949720502821, 4809.0862736080035, 4811.855644330676, 4836.443808962014, 4962.106820772224, 5012.949870501321, 4880.41435027799, 4901.191303434894, 4904.681195722266, 4915.0, 4953.108440480676, 4163.292240319153, 4187.623113919762, 4200.012996945716, 4203.894902627398, 4244.681648876347, 3583.283343331344, 3626.147855254066, 3659.432787917877, 3677.0, 3712.276106159273, 4316.697831151852, 4322.070754787673, 4327.0, 4359.738415695068, 4372.475302963601, 4997.7251251180805, 4997.825076122318, 4998.500149985045, 5021.924671129936, 5047.242913562922, 4143.585641435892, 4250.787460626956, 4252.723572967747, 4279.079997800488, 4326.870193894189, 4472.0, 4485.41689580359, 4492.168948744493, 4498.910021799611, 4500.369948207253, 4750.5249475052215, 4758.4765675776325, 4763.666543342002, 4773.236282194902, 4810.95189048112, 4828.396450443694, 5010.323606313101, 5014.84955451337, 5053.343065401475, 5059.772310245974, 4651.627869770478, 4666.8133274668635, 4673.369095172108, 4697.812087516461, 4807.326974223542, 4919.901601968012, 4950.0, 4952.603791696583, 4953.950460495493, 5002.774875130555, 4993.176125939324, 5018.121828679893, 5018.322526459027, 5024.095662780588, 5063.696178229171, 4628.352030715635, 4708.646851486221, 4783.497732738012, 4784.976075119741, 4853.708777473363, 4866.148424025852, 4866.683665561727, 4883.95116048835, 4886.780094895667, 4915.0, 4733.242681170997, 4776.832810851603, 4780.091782561302, 4785.521447855187, 4828.5412885775795, 4725.1967165581245, 4840.709557426566, 4850.05423942342, 4956.033573453142, 4969.950300496948, 4673.112108699336, 4757.833475828329, 4832.936753914133, 4833.10587541306, 4875.512448755097], "unit": "score", "name": "dojo.html", "value": 4564.5111816607705}, {"lowerIsBetter": false, "replicates": [507.7461269365317, 514.6371807875448, 521.1453216724573, 536.833581589707, 538.1416640458467, 24765.0, 25463.23610291692, 32370.190745231383, 33137.0, 33168.66831331686, 36031.279374412494, 36485.0, 36506.26987460249, 36538.0, 36538.634613653856, 6820.215675197342, 7579.54522728638, 7746.535207887545, 7746.683063879126, 7746.883796743025, 6936.514443988923, 9942.801143977116, 10035.548400321966, 10077.949610251939, 10184.796304073914, 9530.285228607847, 9617.42295462271, 9619.0, 9619.951900240523, 9633.277504187214, 7005.229424763272, 7156.463265255126, 9822.165115965152, 9954.601815927354, 9978.700638980843, 9657.855132173023, 9829.361091529028, 9844.556994935245, 9855.556499957447, 9855.55649995752, 32132.0, 32554.0, 32638.83680581582, 32758.6724132758, 32811.6718832811, 2639.934001649955, 3197.936041279185, 3342.7827191232736, 3350.64818194091, 3375.966240337614, 25380.238592842245, 27491.0, 27613.86193069022, 27730.445391092064, 27994.720052799414, 3165.683431656839, 3202.087405089562, 3231.0, 3233.4018206631613, 3256.951145732816, 168312.0, 168630.0, 169116.15441922835, 169202.0, 169314.99999999878, 45767.77116114465, 46630.533694663296, 53246.0, 53348.73325633347, 53574.196387054224, 52295.21557176646, 52401.7379913098, 52537.47462525326, 52572.21141682878, 52642.73678631582, 11603.709907252387, 11633.53465861373, 11636.301821890713, 11677.532898683958, 11791.764164716658, 7640.350570201484, 7641.961790191013, 7647.502912310682, 7650.655720492591, 7762.495437796638, 17738.29046838138, 18000.549986250448, 18015.63968720618, 18030.639387212446, 18207.453776386465, 6942.479314051467, 7104.147502299757, 7163.964180179066, 7236.312550307713, 7292.270772922665, 717.2863001313726, 836.0093289452019, 839.5927974932154, 967.2938754709102, 973.3819024919227, 26018.6097208542, 26096.086636967615, 26915.86542067277, 27241.0, 27252.0, 881.1628952495155, 891.7503099132254, 946.1673727120091, 991.5820376861013, 1013.0123129948241, 12685.619431417072, 12864.0, 13167.736645267041, 13254.469821207043, 13293.734125317633, 262027.0, 262203.0, 264532.0, 267112.0, 267683.0, 44091.77954110209, 44245.11509769787, 44300.0, 44449.33326000113, 44614.33078503825, 1117.5027112934665, 1164.2839653613137, 1169.6724917023248, 1171.7480741640588, 1173.2901594535183, 21454.463638409165, 24187.879060604584, 24641.137560185307, 26121.216363509124, 27160.407789414934, 38609.42085868658, 38970.0, 39019.804900975316, 39028.219435611696, 39030.0, 196539.0, 198804.0, 198870.0, 199917.0, 199930.0, 24497.877510612332, 24991.625125623494, 28648.14055578336, 29923.850380748827, 30999.690003100583, 35109.0, 35320.29359412849, 35791.28417431585, 36008.639913601575, 36014.27971440504, 30451.086467406014, 30470.847645762515, 30491.2377190572, 31027.53458698076, 31490.0, 31354.843225783727, 31435.214119647193, 31494.37011259716, 31649.20876978094, 31784.0, 30023.69976300209, 30822.0, 30900.60947257334, 30926.690733092382, 30938.845305773328, 26427.60358594661, 28032.859835700692, 28035.43929121447, 28060.29849253785, 28108.71891281143, 22138.33584992453, 22147.55704885861, 22279.888600556893, 22467.88766056159, 22484.77515224827], "unit": "score", "name": "ext.html", "value": 15980.88482866326}, {"lowerIsBetter": false, "replicates": [341.5627996164909, 344.0813029212005, 344.3216862780322, 345.24736075355713, 345.944648856183, 12482.25106493611, 12880.549180778675, 14872.702545949089, 14906.254687265635, 15791.368345266175, 12655.93672031641, 14518.637034074154, 15135.24323783812, 15575.143367114804, 15583.532494025168, 4778.331033655282, 4914.410270767513, 4918.213085906255, 4918.385201849769, 4919.581835543983, 3695.2978934002454, 3826.043489127718, 4849.781759820817, 4883.389576302962, 4892.315075889378, 5511.724413779295, 5648.661080335193, 5657.8585535361535, 5681.857953551153, 5689.203511508392, 5495.230667706504, 5640.407757185498, 5640.633358831663, 5684.175794509814, 5696.231008813798, 5003.724795136266, 5005.974970125126, 5015.874603134915, 5020.523050310215, 5021.472745361721, 17579.824201757947, 18288.359907403177, 18344.53243740511, 19633.705494417594, 19669.60660786776, 1655.188957410872, 1743.076169630098, 1758.9384371547062, 1811.7372980917826, 1933.709943508485, 12980.0, 13093.47626094955, 13131.0, 13219.405126769318, 13251.536196233086, 1597.241310377573, 1686.308613468472, 1719.5443207550009, 1843.4285371534734, 1864.9440516784518, 54388.0, 57851.421485785024, 59173.40826591722, 59416.70291648557, 60718.0, 15170.24148792556, 15248.3900643973, 15252.313645885963, 15258.847411525965, 15280.923595381952, 22783.88608056949, 22826.0, 22945.77054229436, 22961.770382296298, 23102.191423300104, 7952.562609056557, 8031.116577176506, 8042.517448953082, 8100.635471403801, 8128.146544612849, 5849.415058494202, 5859.091840764689, 5876.206712093898, 5911.970440147772, 5950.494207992283, 7374.778756637309, 7453.807390817443, 7528.736494222676, 7532.736354227576, 7685.615719214017, 1741.1033317841323, 2165.8917054147228, 2949.351142748592, 2963.392504536608, 2970.0, 359.12552933606753, 362.3984186250811, 813.9104698483162, 954.2938225712923, 957.6935380678116, 9254.76863078415, 9406.153446189739, 9432.481213533321, 9617.749692539925, 9676.12914837668, 362.0947630922693, 387.0555843741262, 387.59302732131147, 396.0791160551671, 397.48525659271314, 5047.268146118866, 5074.11203039474, 5082.33929589151, 5091.3126727892, 5209.0, 534448.0, 552636.0, 562327.0, 562975.0, 574855.0, 56634.58413539612, 62331.68834155891, 63177.0, 66951.0, 70923.2907670927, 1004.1113614451117, 1022.9232807539464, 1027.7841653252751, 1032.0814475117152, 1043.9060484556273, 13884.375203115682, 14135.010549261864, 14842.851571484147, 14932.02941808779, 14938.626534336294, 22801.973911173704, 29047.854760726063, 29857.0, 30613.54079688762, 31038.068857934297, 39478.0, 40240.19519609533, 40647.59352406557, 41243.1751364977, 42267.36598950957, 8653.913460865311, 9056.36605437613, 9372.765680858032, 9404.670836520689, 9407.529623518934, 16030.358785648443, 16092.0, 16344.182790860172, 16590.83409165893, 16799.244034018255, 13364.398602062736, 13473.258970756311, 13533.458661653423, 14188.858111419167, 14320.856791431952, 13107.0, 13650.863491364958, 13703.383347749175, 13721.382537786023, 14223.431062757374, 10535.852062022388, 12528.87471125277, 13908.791368129689, 13971.790423143864, 14575.635609109857, 8106.513609183467, 8396.664133434595, 8450.408471406943, 8479.703210387606, 8962.058983806866, 9070.954645226731, 9324.627014919328, 9326.626934922528, 11216.327020378803, 14449.060811047248], "unit": "score", "name": "jquery.html", "value": 8242.307800912678}, {"lowerIsBetter": false, "replicates": [1213.939303034848, 1371.3897315694517, 1393.010962216826, 1488.4567132996453, 1719.6560687862432, 6143.692815359231, 6737.461003119751, 6842.589444633326, 6941.479389045817, 6945.479089068315, 6999.23008469068, 7142.321479459456, 7221.061262035928, 7223.4221262299025, 7234.421246300297, 2073.3676228750264, 2119.2900378373265, 2121.448423409917, 2121.6075026120216, 2122.734658167729, 2102.295730930133, 2126.7873212678687, 2150.623640862843, 2165.17723265159, 2174.836887233456, 2070.3167954574956, 2073.6785798201304, 2080.8127268545904, 2105.631514484967, 2106.6208082545136, 2079.8128168464837, 2096.0, 2109.2617583845686, 2109.641360968639, 2109.947251318714, 2068.700038494425, 2102.6530622447276, 2109.8101170894693, 2113.3131732187103, 2114.0381126587367, 7122.0, 7191.35277824993, 7193.856122877513, 7199.1001124859395, 7202.4238060954995, 4203.7057405981595, 4234.745915245096, 4269.530351661346, 4281.079567892918, 4283.271843786564, 2679.6650418697664, 2688.4354285600048, 2715.8777854996574, 2729.7952653550865, 2733.425980544088, 808.8180159464132, 856.5503110866782, 856.9228769410782, 857.1471385970937, 892.4600616626977, 9307.34848560601, 9327.580258888298, 9330.953345233298, 9367.297452691075, 9379.953100234523, 3833.5783063862955, 3844.1735026969336, 3899.74651647642, 3933.2920074386884, 3933.7246392752804, 8155.429119961665, 8190.959045204736, 8191.180881911761, 8194.713185038614, 8195.631196596167, 4245.57544245573, 4255.936160957588, 4280.6789490788315, 4282.272013757669, 4286.099919016979, 3320.701136897691, 3395.864165433404, 3726.5900750917376, 3846.788426636562, 3869.941950870739, 3351.564296641421, 3384.1539615096226, 3399.745019123526, 3414.641462646436, 3438.3123375325035, 1068.759529105945, 1085.7448499602588, 1086.983695244572, 1095.2333366643381, 1098.2861140258735, 863.1842908451453, 869.0787764969153, 872.2237208884098, 876.071364353787, 914.6432891172448, 6795.150606174228, 6860.211075726255, 6861.588304701734, 6877.346652068046, 6882.827929301708, 1000.8999100089933, 1009.6970908727352, 1012.5949620151998, 1019.56158851693, 1033.0650761061252, 4795.976020119947, 4813.205821039559, 4821.252705830531, 4825.179719447702, 4825.662203645781, 8264.793380165544, 8460.153984601613, 8657.696980605648, 8669.133086691407, 8724.69463568772, 8173.713920012771, 8178.754637360769, 8280.254777070093, 8359.665613375397, 8387.412881098386, 6739.0, 6779.3220677932795, 6782.016607591871, 6805.625690586966, 6816.931830681729, 6361.904571431525, 6520.054592084027, 6535.5425120241125, 6549.705263263069, 6551.050097735897, 7546.735864244725, 7690.577018263825, 7726.613669316399, 7898.407619428681, 7956.801079973047, 7836.09884863248, 8014.198580142172, 8089.514629122272, 8111.351091912515, 8123.47197432165, 5498.0, 5594.356648985418, 6334.524910631629, 6386.16979792624, 6414.5189110815945, 6413.583117097373, 6446.677666116581, 6507.934920650733, 6528.543001990005, 6532.967335163294, 6118.174046503665, 6244.250689917239, 6311.27420346666, 6347.143135676809, 6512.804615861532, 6174.536909731878, 6242.188515492957, 6256.092866534418, 6331.715072821642, 6350.206224221973, 6202.193714817045, 6214.751409943732, 6230.06549017651, 6350.809475715736, 6367.267764207176, 6014.097885317237, 6024.90962635552, 6042.486388657014, 6047.455728984412, 6052.303985041776, 5944.73248703818, 6030.276366836008, 6048.0, 6055.909161362495, 6056.9091463628965], "unit": "score", "name": "mootools.html", "value": 4045.465920968291}, {"lowerIsBetter": false, "replicates": [299.19367305112723, 309.06815949911015, 309.4260147426524, 323.1356122372654, 326.85781684967054, 5185.325907632007, 5287.233351164084, 5308.548773354265, 5388.407275199725, 5441.918371224435, 5251.369835619731, 5308.946910530894, 5320.14877619581, 5330.786768529254, 5340.599455040868, 3923.1761330120707, 4009.9198016039663, 4015.3575427931537, 4131.297679394495, 4132.814023368941, 4085.305498065336, 4092.631663150316, 4093.2427500912427, 4101.774402407867, 4146.751194928314, 4096.283150448675, 4096.918061638766, 4098.118904435546, 4100.979495102535, 4106.733062350952, 3884.844606215748, 3973.1656352166224, 3980.20395920817, 4049.0, 4055.797210139481, 3559.110222444389, 3585.318789430026, 3591.6947059499976, 3596.892093237207, 3602.2975519773654, 5017.523335283142, 5019.498050194988, 5029.2958985742025, 5031.723255220962, 5043.773030213649, 4710.505396933341, 4715.1512727709, 4715.198416269242, 4723.07899959508, 4725.0, 5439.619226654136, 5552.77788888444, 5557.166425036277, 5568.136938774496, 5570.526505247059, 3905.9218815623813, 3917.9216415671813, 3918.0792513759243, 3919.2357490289405, 3924.50943632046, 5767.625104368202, 5859.1797148399255, 5862.794802181903, 5868.647881127146, 5869.647821130746, 4035.0315924177985, 4038.7172897897453, 4044.6359827615065, 4044.8584299549375, 4045.959540404617, 3982.8406863725704, 4083.9387409188885, 4097.91804163921, 4099.426080348753, 4109.650679692199, 4652.976735116303, 4658.231391820379, 4663.0, 4665.533446655375, 4671.602913752369, 5539.390667026624, 5540.418256083134, 5540.778368865281, 5543.805966791143, 5545.417731138173, 1410.4146779086564, 1432.3053319140208, 1434.7560914644534, 1435.5119259451628, 1436.5259464376938, 943.6036864516919, 957.3920560444029, 965.0976337124811, 994.9452780097164, 997.8203923293731, 4911.950880491221, 4916.06594746997, 4924.630652701062, 4931.580815630711, 4939.753012349368, 5749.0, 5749.88500229993, 5750.108733146285, 5752.194692743019, 5754.88490230193, 4914.803407863646, 4920.138975679241, 4921.212605983025, 4923.335349727812, 4923.433805112458, 2882.6973167817496, 2976.791624586258, 3061.112277439562, 3080.6919308069014, 3107.6426210985574, 5513.448655134454, 5547.417521160301, 5549.278593782782, 5549.417311182348, 5554.611177217636, 5920.911186332209, 5926.7925622603, 5932.2584676915385, 5944.7324870380935, 5975.940240597538, 5535.474129957647, 5537.861553461195, 5542.889142217214, 5543.974364742536, 5552.8056518023295, 5602.915956260578, 5753.2520772301, 5768.336641286306, 5816.76732930678, 5854.443827836349, 5694.800681976111, 5696.658200507983, 5698.629589076697, 5700.743466543932, 5703.429657034263, 5538.030844602259, 5541.196526503554, 5545.279113715191, 5546.889062218653, 5558.972205138948, 3900.1419687668667, 4017.9598204017584, 4051.6961227908614, 4054.655354294918, 4055.3916912463364, 5769.0, 5774.94225057744, 5777.826665200051, 5782.161586570008, 5789.681567513827, 5574.303212098488, 5617.4101719320515, 5618.494335509824, 5629.099344104923, 5629.605927585029, 5528.612997090165, 5529.30883639545, 5531.0, 5533.418991006048, 5538.889222215614, 5295.205719142159, 5415.214793854948, 5423.430539793423, 5427.972860135674, 5435.429279925551, 5587.217789509553, 5598.664080155204, 5605.495505404533, 5610.242617246619, 5624.859378515406, 5247.291615631841, 5332.920006199833, 5403.675779453245, 5523.475269849358, 5530.695811730394], "unit": "score", "name": "prototype.html", "value": 4191.337371178011}, {"lowerIsBetter": false, "replicates": [744.601638123604, 746.775967209837, 749.3742724824771, 757.2692351880435, 760.410681721666, 11281.210315277924, 11394.25937314074, 11402.201845870772, 11426.600068997586, 11433.485493152808, 10798.622048228313, 10979.61571345003, 11161.0, 11170.776584468305, 11183.83224251637, 765.9655315510815, 782.5500337306044, 782.8825676148595, 783.0720596093619, 783.8471498057881, 770.3336613829053, 776.6621519638946, 777.7627823513826, 778.2723153851167, 778.3967425245452, 799.1808396393685, 808.7169490678245, 810.1533897077568, 810.5177419435427, 810.5825499867543, 797.0435477427081, 799.1050023973158, 801.9879701804477, 803.1687203744156, 805.6334367862609, 599.7660912244228, 600.2586805295457, 600.7026521871658, 600.906859436788, 601.0203368509345, 11478.598249061326, 11604.361760103191, 11626.825597616042, 11627.244229125165, 11678.182527223098, 10964.232503724743, 11047.779044419147, 11052.115830733523, 11057.557697692082, 11411.828822567668, 8939.508327042011, 8954.149355811187, 8960.23837973773, 9052.502112383816, 9071.682491112779, 3206.8075915445147, 3227.0964130043626, 3242.270489139948, 3265.8367081645824, 3285.3593549257666, 32846.0, 33088.83455582731, 35840.283194336225, 36564.81717591395, 36648.0, 9342.019087995663, 9359.391639543408, 9632.90367096334, 9697.6605818796, 9786.266030047775, 15234.77147842761, 15275.694486110215, 15352.232388380537, 15362.155081470626, 15385.922900408525, 6185.072239164161, 6251.12484252205, 6274.215723034621, 6375.808725738235, 6496.252930912911, 3026.1980575147604, 3310.9404990403323, 3350.463925771865, 3373.9493907591404, 3448.9655103448645, 2943.632045994251, 2967.4806908790874, 2974.1226338230276, 2974.7174018468645, 2976.940461190764, 517.7721802406929, 518.7561845932406, 520.7162096657331, 521.0382908350065, 525.8080800507787, 394.7631421147346, 427.4016377072062, 479.37441638661187, 490.4898905138687, 508.9058524172984, 6681.231658359254, 6903.447724182053, 7037.964810175917, 7048.647567621599, 7642.273983971514, 407.8083300848656, 502.8491452564216, 513.2942204468856, 527.4593541619794, 531.7181893596401, 2885.653721553427, 3055.358374741285, 3165.9525107123413, 3245.221146924721, 3267.166872447558, 47536.04927901422, 47634.285485717744, 47940.0, 47956.28065579019, 47974.28038579424, 41871.37192942108, 41939.37090943638, 42054.36918446226, 42059.7897010513, 42134.57865421368, 34761.65238347584, 34850.30299393998, 44074.33888491675, 45699.08601827945, 46254.53745462569, 6944.027836102849, 7253.3834624057545, 7258.528195667264, 7353.742619008309, 7604.695812167673, 29021.419571608873, 29294.26764330909, 29900.401991959603, 30368.392632147676, 30439.695603043685, 36742.26515469729, 38023.42964855474, 38188.236235274584, 38842.805785970886, 38874.80562597169, 9785.951070244602, 10063.647772327933, 10134.0, 10203.0, 10353.378797272188, 11070.667879963614, 11313.377764223047, 11319.0, 11466.31202127875, 12101.818472723093, 9108.635654573744, 9177.128172823572, 9352.953235234052, 9585.281103917094, 9625.855612165684, 9763.365381250196, 9766.36518626287, 10057.245706572183, 10453.372797632166, 10650.627228046982, 9045.412048216846, 9207.217386521952, 9207.58565864551, 9299.953500232456, 9319.30105242096, 9435.150836424755, 9613.663521776703, 9859.0, 9977.251706121924, 10208.489575521342, 8054.315383192495, 8416.537090459839, 8438.957805211181, 8454.619542120496, 8623.310135189044], "unit": "score", "name": "yui.html", "value": 5483.430838356405}], "name": "dromaeo_css", "value": 6183.630624600901}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 113.0, 116.0, 103.0, 112.0, 113.0, 102.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 153.0, 172.0, 130.0, 157.0, 153.0, 129.0, 166.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 83.0, 91.0, 71.0, 73.0, 73.0, 98.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 140.0, 97.0, 98.0, 98.0, 135.0, 97.0, 98.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 68.0, 69.0, 77.0, 68.0, 78.0, 68.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 70.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 69.0, 71.0, 68.0, 69.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 101.0, 93.0, 85.0, 84.0, 84.0, 93.0, 94.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 121.0, 121.0, 118.0, 125.0, 139.0, 130.0, 119.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 150.0, 148.0, 147.0, 143.0, 148.0, 148.0, 145.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 71.0, 70.0, 70.0, 70.0, 73.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1528.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [188.07598269700958], "unit": "score", "name": "DeltaBlue", "value": 351.549406}, {"lowerIsBetter": false, "replicates": [282.80542986425337], "unit": "score", "name": "Encrypt", "value": 941.2160160000003}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [807.1025020177563], "unit": "score", "name": "Earley", "value": 825.7476570000002}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [619.5786864931846], "unit": "score", "name": "Splay", "value": 131.52647400000006}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19657.63165388522}]} 22:49:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19657.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6183.63"}}} 22:49:51 INFO - Return code: 0 22:49:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:49:52 INFO - # TBPL SUCCESS # 22:49:52 INFO - Running post-action listener: _resource_record_post_action 22:49:52 INFO - Running post-run listener: _resource_record_post_run 22:49:53 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545763328; Read time: 8; Write time: 492532 22:49:53 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234369024; Read time: 0; Write time: 284428 22:49:53 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311394304; Read time: 8; Write time: 208104 22:49:53 INFO - Running post-run listener: _upload_blobber_files 22:49:53 INFO - Blob upload gear active. 22:49:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:49:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:49:53 INFO - (blobuploader) - INFO - Open directory for files ... 22:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:54 INFO - (blobuploader) - INFO - Done attempting. 22:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:55 INFO - (blobuploader) - INFO - Done attempting. 22:49:55 INFO - (blobuploader) - INFO - Iteration through files over. 22:49:55 INFO - Return code: 0 22:49:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:49:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:49:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/777b9e2fe46f85905d810aafa6788cd894e8c57dd7f62cc8c364ae05f1576da8b9fa3df37693ac01fcbd7260f3f413541a5e11d1cc696684d412b620465cc9a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d718240c3aa321d1357623aa472255862b7a6cfdb0ae57694f12f16365a8c64b05ba43f674a35f97f81b4711356dc296936c2cbd4e6c802e7a3d632d6d4458cd"} 22:49:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:49:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:49:55 INFO - Contents: 22:49:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/777b9e2fe46f85905d810aafa6788cd894e8c57dd7f62cc8c364ae05f1576da8b9fa3df37693ac01fcbd7260f3f413541a5e11d1cc696684d412b620465cc9a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d718240c3aa321d1357623aa472255862b7a6cfdb0ae57694f12f16365a8c64b05ba43f674a35f97f81b4711356dc296936c2cbd4e6c802e7a3d632d6d4458cd"} 22:49:55 INFO - Copying logs to upload dir... 22:49:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1284.965799 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-29 22:49:55.076441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:55.080186) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/777b9e2fe46f85905d810aafa6788cd894e8c57dd7f62cc8c364ae05f1576da8b9fa3df37693ac01fcbd7260f3f413541a5e11d1cc696684d412b620465cc9a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d718240c3aa321d1357623aa472255862b7a6cfdb0ae57694f12f16365a8c64b05ba43f674a35f97f81b4711356dc296936c2cbd4e6c802e7a3d632d6d4458cd"} build_url:https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/777b9e2fe46f85905d810aafa6788cd894e8c57dd7f62cc8c364ae05f1576da8b9fa3df37693ac01fcbd7260f3f413541a5e11d1cc696684d412b620465cc9a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d718240c3aa321d1357623aa472255862b7a6cfdb0ae57694f12f16365a8c64b05ba43f674a35f97f81b4711356dc296936c2cbd4e6c802e7a3d632d6d4458cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:55.110062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:55.110427) ========= 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=70a720fcaf18edea6683c2dc000001ad-1451455928.584701-456416639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:55.193357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:49:55.193669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:49:55.194011) ========= ========= Total master_lag: 0.26 =========