builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1451456904.47 results: success (0) buildid: 20151229215139 builduid: 7dc77199cbeb4c7287884a11d3f67470 revision: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.471270) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.471728) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.472028) ========= 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=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.507206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.507520) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.551313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.551585) ========= 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=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.600826) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.601155) ========= 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:24.601567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.601876) ========= 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=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 22:28:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-29 22:28:25 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.788850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.789313) ========= 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=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017634 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.847025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:24.847488) ========= 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=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 22:28:25,503 truncating revision to first 12 chars 2015-12-29 22:28:25,503 Setting DEBUG logging. 2015-12-29 22:28:25,503 attempt 1/10 2015-12-29 22:28:25,503 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:25,862 unpacking tar archive at: fx-team-77420c71e0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659059 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:25.520262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:25.520581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:25.533585) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 22:28:25.533835) ========= 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:25.534287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-29 22:28:25.534650) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:28:26 INFO - MultiFileLogger online at 20151229 22:28:26 in /builds/slave/test 22:28:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:28:26 INFO - {'append_to_log': False, 22:28:26 INFO - 'base_work_dir': '/builds/slave/test', 22:28:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:28:26 INFO - 'branch': 'Fx-Team-Non-PGO', 22:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:28:26 INFO - 'config_files': ('talos/linux_config.py',), 22:28:26 INFO - 'default_actions': ('clobber', 22:28:26 INFO - 'read-buildbot-config', 22:28:26 INFO - 'download-and-extract', 22:28:26 INFO - 'populate-webroot', 22:28:26 INFO - 'create-virtualenv', 22:28:26 INFO - 'install', 22:28:26 INFO - 'run-tests'), 22:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:28:26 INFO - 'download_minidump_stackwalk': True, 22:28:26 INFO - 'download_symbols': 'ondemand', 22:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:28:26 INFO - 'installer_path': 'installer.exe', 22:28:26 INFO - 'log_level': 'info', 22:28:26 INFO - 'log_name': 'talos', 22:28:26 INFO - 'log_to_console': True, 22:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:28:26 INFO - 'opt_config_files': (), 22:28:26 INFO - 'pip_index': False, 22:28:26 INFO - 'sps_profile': False, 22:28:26 INFO - 'sps_profile_interval': 0, 22:28:26 INFO - 'suite': 'dromaeojs-e10s', 22:28:26 INFO - 'system_bits': '32', 22:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:28:26 INFO - 'title': 'talos-linux64-ix-045', 22:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:28:26 INFO - 'use_talos_json': True, 22:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:28:26 INFO - 'work_dir': 'build'} 22:28:26 INFO - ##### 22:28:26 INFO - ##### Running clobber step. 22:28:26 INFO - ##### 22:28:26 INFO - Running pre-action listener: _resource_record_pre_action 22:28:26 INFO - Running main action method: clobber 22:28:26 INFO - rmtree: /builds/slave/test/build 22:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:28:26 INFO - Running post-action listener: _resource_record_post_action 22:28:26 INFO - ##### 22:28:26 INFO - ##### Running read-buildbot-config step. 22:28:26 INFO - ##### 22:28:26 INFO - Running pre-action listener: _resource_record_pre_action 22:28:26 INFO - Running main action method: read_buildbot_config 22:28:26 INFO - Using buildbot properties: 22:28:26 INFO - { 22:28:26 INFO - "project": "", 22:28:26 INFO - "product": "firefox", 22:28:26 INFO - "script_repo_revision": "production", 22:28:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:28:26 INFO - "repository": "", 22:28:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:28:26 INFO - "buildid": "20151229215139", 22:28:26 INFO - "pgo_build": "False", 22:28:26 INFO - "basedir": "/builds/slave/test", 22:28:26 INFO - "buildnumber": 864, 22:28:26 INFO - "slavename": "talos-linux64-ix-045", 22:28:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:28:26 INFO - "platform": "ubuntu64_hw", 22:28:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:28:26 INFO - "branch": "fx-team", 22:28:26 INFO - "repo_path": "integration/fx-team", 22:28:26 INFO - "revision": "77420c71e0d49620c056cbd4a74cb1e41a891ac5", 22:28:26 INFO - "stage_platform": "linux64", 22:28:26 INFO - "builduid": "7dc77199cbeb4c7287884a11d3f67470", 22:28:26 INFO - "slavebuilddir": "test" 22:28:26 INFO - } 22:28:26 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:26 INFO - Running post-action listener: _resource_record_post_action 22:28:26 INFO - ##### 22:28:26 INFO - ##### Running download-and-extract step. 22:28:26 INFO - ##### 22:28:26 INFO - Running pre-action listener: _resource_record_pre_action 22:28:26 INFO - Running main action method: download_and_extract 22:28:26 INFO - mkdir: /builds/slave/test/build/tests 22:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:26 INFO - https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:28:26 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:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/test_packages.json 22:28:26 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:26 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:28 INFO - Downloaded 1302 bytes. 22:28:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:28:28 INFO - Using the following test package requirements: 22:28:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:28:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:28 INFO - u'jsshell-linux-x86_64.zip'], 22:28:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:28:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:28:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:28:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:28:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:28:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:28:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:28:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:28:28 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:28 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:28 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:28 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:28 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:28 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:29 INFO - Downloaded 21943114 bytes. 22:28:29 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:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:29 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:30 INFO - Return code: 0 22:28:30 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:30 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:30 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:30 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:30 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:30 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:30 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:31 INFO - Downloaded 21943114 bytes. 22:28:31 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:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:28:31 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:32 INFO - Return code: 0 22:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:32 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:32 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:32 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:32 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:32 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:34 INFO - Downloaded 11132285 bytes. 22:28:34 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:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:28:34 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:34 INFO - Return code: 0 22:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:34 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:34 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:34 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:34 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:34 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:35 INFO - Downloaded 53321834 bytes. 22:28:35 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:35 INFO - mkdir: /builds/slave/test/properties 22:28:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:28:35 INFO - Writing to file /builds/slave/test/properties/build_url 22:28:35 INFO - Contents: 22:28:35 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:35 INFO - Running post-action listener: _resource_record_post_action 22:28:35 INFO - Running post-action listener: set_extra_try_arguments 22:28:35 INFO - ##### 22:28:35 INFO - ##### Running populate-webroot step. 22:28:35 INFO - ##### 22:28:35 INFO - Running pre-action listener: _resource_record_pre_action 22:28:35 INFO - Running main action method: populate_webroot 22:28:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:28:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:28:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:28:35 INFO - '--tppagecycles', 22:28:35 INFO - '7'], 22:28:35 INFO - 'tests': ['tsvgm']}}, 22:28:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:28:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:28:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:28:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:28:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'tests': ['damp', 'tps']}, 22:28:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['damp', 'tps']}, 22:28:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:28:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:28:35 INFO - 'other': {'tests': ['a11yr', 22:28:35 INFO - 'ts_paint', 22:28:35 INFO - 'tpaint', 22:28:35 INFO - 'sessionrestore', 22:28:35 INFO - 'sessionrestore_no_auto_restore']}, 22:28:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['a11yr', 22:28:35 INFO - 'ts_paint', 22:28:35 INFO - 'tpaint', 22:28:35 INFO - 'sessionrestore', 22:28:35 INFO - 'sessionrestore_no_auto_restore']}, 22:28:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['a11yr', 22:28:35 INFO - 'ts_paint', 22:28:35 INFO - 'tpaint', 22:28:35 INFO - 'sessionrestore', 22:28:35 INFO - 'sessionrestore_no_auto_restore']}, 22:28:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['a11yr', 22:28:35 INFO - 'ts_paint', 22:28:35 INFO - 'tpaint', 22:28:35 INFO - 'sessionrestore', 22:28:35 INFO - 'sessionrestore_no_auto_restore']}, 22:28:35 INFO - 'other_l64': {'tests': ['a11yr', 22:28:35 INFO - 'ts_paint', 22:28:35 INFO - 'tpaint', 22:28:35 INFO - 'sessionrestore', 22:28:35 INFO - 'sessionrestore_no_auto_restore']}, 22:28:35 INFO - 'other_nol64': {'tests': ['a11yr', 22:28:35 INFO - 'ts_paint', 22:28:35 INFO - 'tpaint', 22:28:35 INFO - 'sessionrestore', 22:28:35 INFO - 'sessionrestore_no_auto_restore']}, 22:28:35 INFO - 'svgr': {'tests': ['tsvgx', 22:28:35 INFO - 'tsvgr_opacity', 22:28:35 INFO - 'tart', 22:28:35 INFO - 'tscrollx', 22:28:35 INFO - 'cart']}, 22:28:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['tsvgx', 22:28:35 INFO - 'tsvgr_opacity', 22:28:35 INFO - 'tart', 22:28:35 INFO - 'tscrollx', 22:28:35 INFO - 'cart']}, 22:28:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'tests': ['tp5o']}, 22:28:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'talos_options': ['--e10s'], 22:28:35 INFO - 'tests': ['tp5o']}, 22:28:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'talos_options': ['--xperf_path', 22:28:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:35 INFO - 'tests': ['tp5n']}, 22:28:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:35 INFO - 'talos_options': ['--e10s', 22:28:35 INFO - '--xperf_path', 22:28:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:35 INFO - 'tests': ['tp5n']}}, 22:28:35 INFO - 'talos.zip': {'path': '', 22:28:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:28:35 INFO - Running post-action listener: _resource_record_post_action 22:28:35 INFO - ##### 22:28:35 INFO - ##### Running create-virtualenv step. 22:28:35 INFO - ##### 22:28:35 INFO - Running pre-action listener: _resource_record_pre_action 22:28:35 INFO - Running main action method: create_virtualenv 22:28:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:28:35 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:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:28:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:28:35 INFO - Using real prefix '/usr' 22:28:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:28:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:28:38 INFO - Installing pip.................done. 22:28:38 INFO - Return code: 0 22:28:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:28:38 INFO - Using env: {'DISPLAY': ':0', 22:28:38 INFO - 'HOME': '/home/cltbld', 22:28:38 INFO - 'LANG': 'en_US.UTF-8', 22:28:38 INFO - 'LANGUAGE': 'en_US:en', 22:28:38 INFO - 'LOGNAME': 'cltbld', 22:28:38 INFO - 'MAIL': '/var/mail/cltbld', 22:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:38 INFO - 'MOZ_NO_REMOTE': '1', 22:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:38 INFO - 'NO_EM_RESTART': '1', 22:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:38 INFO - 'PWD': '/builds/slave/test', 22:28:38 INFO - 'SHELL': '/bin/bash', 22:28:38 INFO - 'SHLVL': '1', 22:28:38 INFO - 'TERM': 'linux', 22:28:38 INFO - 'TMOUT': '86400', 22:28:38 INFO - 'USER': 'cltbld', 22:28:38 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:38 INFO - '_': '/tools/buildbot/bin/python'} 22:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:38 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:38 INFO - Cleaning up... 22:28:38 INFO - Return code: 0 22:28:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:28:38 INFO - Using env: {'DISPLAY': ':0', 22:28:38 INFO - 'HOME': '/home/cltbld', 22:28:38 INFO - 'LANG': 'en_US.UTF-8', 22:28:38 INFO - 'LANGUAGE': 'en_US:en', 22:28:38 INFO - 'LOGNAME': 'cltbld', 22:28:38 INFO - 'MAIL': '/var/mail/cltbld', 22:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:38 INFO - 'MOZ_NO_REMOTE': '1', 22:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:38 INFO - 'NO_EM_RESTART': '1', 22:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:38 INFO - 'PWD': '/builds/slave/test', 22:28:38 INFO - 'SHELL': '/bin/bash', 22:28:38 INFO - 'SHLVL': '1', 22:28:38 INFO - 'TERM': 'linux', 22:28:38 INFO - 'TMOUT': '86400', 22:28:38 INFO - 'USER': 'cltbld', 22:28:38 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:38 INFO - '_': '/tools/buildbot/bin/python'} 22:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:38 INFO - Downloading/unpacking psutil>=0.7.1 22:28:38 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:38 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:38 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:38 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:38 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:38 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:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:28:40 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:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:40 INFO - Installing collected packages: psutil 22:28:40 INFO - Running setup.py install for psutil 22:28:40 INFO - building 'psutil._psutil_linux' extension 22:28:40 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:40 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:40 INFO - building 'psutil._psutil_posix' extension 22:28:40 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:40 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:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:40 INFO - Successfully installed psutil 22:28:40 INFO - Cleaning up... 22:28:41 INFO - Return code: 0 22:28:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 22:28:41 INFO - 'HOME': '/home/cltbld', 22:28:41 INFO - 'LANG': 'en_US.UTF-8', 22:28:41 INFO - 'LANGUAGE': 'en_US:en', 22:28:41 INFO - 'LOGNAME': 'cltbld', 22:28:41 INFO - 'MAIL': '/var/mail/cltbld', 22:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:41 INFO - 'MOZ_NO_REMOTE': '1', 22:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:41 INFO - 'NO_EM_RESTART': '1', 22:28:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:41 INFO - 'PWD': '/builds/slave/test', 22:28:41 INFO - 'SHELL': '/bin/bash', 22:28:41 INFO - 'SHLVL': '1', 22:28:41 INFO - 'TERM': 'linux', 22:28:41 INFO - 'TMOUT': '86400', 22:28:41 INFO - 'USER': 'cltbld', 22:28:41 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:41 INFO - '_': '/tools/buildbot/bin/python'} 22:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:28:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:28:42 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:28:42 INFO - Installing collected packages: mozsystemmonitor 22:28:42 INFO - Running setup.py install for mozsystemmonitor 22:28:43 INFO - Successfully installed mozsystemmonitor 22:28:43 INFO - Cleaning up... 22:28:43 INFO - Return code: 0 22:28:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:28:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:43 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 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:43 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:28:43 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:28:43 INFO - Using env: {'DISPLAY': ':0', 22:28:43 INFO - 'HOME': '/home/cltbld', 22:28:43 INFO - 'LANG': 'en_US.UTF-8', 22:28:43 INFO - 'LANGUAGE': 'en_US:en', 22:28:43 INFO - 'LOGNAME': 'cltbld', 22:28:43 INFO - 'MAIL': '/var/mail/cltbld', 22:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:43 INFO - 'MOZ_NO_REMOTE': '1', 22:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:43 INFO - 'NO_EM_RESTART': '1', 22:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:43 INFO - 'PWD': '/builds/slave/test', 22:28:43 INFO - 'SHELL': '/bin/bash', 22:28:43 INFO - 'SHLVL': '1', 22:28:43 INFO - 'TERM': 'linux', 22:28:43 INFO - 'TMOUT': '86400', 22:28:43 INFO - 'USER': 'cltbld', 22:28:43 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:43 INFO - '_': '/tools/buildbot/bin/python'} 22:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:28:43 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:43 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:43 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:43 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:43 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:43 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:45 INFO - Downloading blobuploader-1.2.4.tar.gz 22:28:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:28:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:28:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:45 INFO - Downloading docopt-0.6.1.tar.gz 22:28:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:28:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:28:45 INFO - Running setup.py install for blobuploader 22:28:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:28:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:28:45 INFO - Running setup.py install for requests 22:28:46 INFO - Running setup.py install for docopt 22:28:46 INFO - Successfully installed blobuploader requests docopt 22:28:46 INFO - Cleaning up... 22:28:46 INFO - Return code: 0 22:28:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:46 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 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:46 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:28:46 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:28:46 INFO - Using env: {'DISPLAY': ':0', 22:28:46 INFO - 'HOME': '/home/cltbld', 22:28:46 INFO - 'LANG': 'en_US.UTF-8', 22:28:46 INFO - 'LANGUAGE': 'en_US:en', 22:28:46 INFO - 'LOGNAME': 'cltbld', 22:28:46 INFO - 'MAIL': '/var/mail/cltbld', 22:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:46 INFO - 'MOZ_NO_REMOTE': '1', 22:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:46 INFO - 'NO_EM_RESTART': '1', 22:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:46 INFO - 'PWD': '/builds/slave/test', 22:28:46 INFO - 'SHELL': '/bin/bash', 22:28:46 INFO - 'SHLVL': '1', 22:28:46 INFO - 'TERM': 'linux', 22:28:46 INFO - 'TMOUT': '86400', 22:28:46 INFO - 'USER': 'cltbld', 22:28:46 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:46 INFO - '_': '/tools/buildbot/bin/python'} 22:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:46 INFO - Running setup.py (path:/tmp/pip-JyYOiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:46 INFO - Running setup.py (path:/tmp/pip-baTOeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:46 INFO - Running setup.py (path:/tmp/pip-jj4HFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:46 INFO - Running setup.py (path:/tmp/pip-UeKvYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:46 INFO - Running setup.py (path:/tmp/pip-_opJd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:46 INFO - Running setup.py (path:/tmp/pip-GVLURS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:46 INFO - Running setup.py (path:/tmp/pip-6imejI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:47 INFO - Running setup.py (path:/tmp/pip-32BT4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:47 INFO - Running setup.py (path:/tmp/pip-UMjmXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:47 INFO - Running setup.py (path:/tmp/pip-iC7T1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:47 INFO - Running setup.py (path:/tmp/pip-eiD8tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:47 INFO - Running setup.py (path:/tmp/pip-XwfxS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:47 INFO - Running setup.py (path:/tmp/pip-S8HUrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:47 INFO - Running setup.py (path:/tmp/pip-GIyeJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:47 INFO - Running setup.py (path:/tmp/pip-oxsVpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:47 INFO - Running setup.py (path:/tmp/pip-iMLtWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:47 INFO - Running setup.py (path:/tmp/pip-ivSE9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:28:47 INFO - Running setup.py install for manifestparser 22:28:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:28:47 INFO - Running setup.py install for mozcrash 22:28:47 INFO - Running setup.py install for mozdebug 22:28:48 INFO - Running setup.py install for mozdevice 22:28:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Running setup.py install for mozfile 22:28:48 INFO - Running setup.py install for mozhttpd 22:28:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Running setup.py install for mozinfo 22:28:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Running setup.py install for mozInstall 22:28:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Running setup.py install for mozleak 22:28:48 INFO - Running setup.py install for mozlog 22:28:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Running setup.py install for moznetwork 22:28:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:28:48 INFO - Running setup.py install for mozprocess 22:28:49 INFO - Running setup.py install for mozprofile 22:28:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:28:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:28:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:28:49 INFO - Running setup.py install for mozrunner 22:28:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:28:49 INFO - Running setup.py install for mozscreenshot 22:28:49 INFO - Running setup.py install for moztest 22:28:49 INFO - Running setup.py install for mozversion 22:28:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:28:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:28:49 INFO - Cleaning up... 22:28:49 INFO - Return code: 0 22:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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:28:49 INFO - Using env: {'DISPLAY': ':0', 22:28:49 INFO - 'HOME': '/home/cltbld', 22:28:49 INFO - 'LANG': 'en_US.UTF-8', 22:28:49 INFO - 'LANGUAGE': 'en_US:en', 22:28:49 INFO - 'LOGNAME': 'cltbld', 22:28:49 INFO - 'MAIL': '/var/mail/cltbld', 22:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:49 INFO - 'MOZ_NO_REMOTE': '1', 22:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:49 INFO - 'NO_EM_RESTART': '1', 22:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:49 INFO - 'PWD': '/builds/slave/test', 22:28:49 INFO - 'SHELL': '/bin/bash', 22:28:49 INFO - 'SHLVL': '1', 22:28:49 INFO - 'TERM': 'linux', 22:28:49 INFO - 'TMOUT': '86400', 22:28:49 INFO - 'USER': 'cltbld', 22:28:49 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:49 INFO - '_': '/tools/buildbot/bin/python'} 22:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:49 INFO - Running setup.py (path:/tmp/pip-8ZWuJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:49 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:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:49 INFO - Running setup.py (path:/tmp/pip-NHoAZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:49 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:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:49 INFO - Running setup.py (path:/tmp/pip-UI3E7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:50 INFO - Running setup.py (path:/tmp/pip-GYhTC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:50 INFO - Running setup.py (path:/tmp/pip-2eyHXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:50 INFO - Running setup.py (path:/tmp/pip-4_Qjdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:50 INFO - Running setup.py (path:/tmp/pip-XyouCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:50 INFO - Running setup.py (path:/tmp/pip-RP_KHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:50 INFO - Running setup.py (path:/tmp/pip-bsx5LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:50 INFO - Running setup.py (path:/tmp/pip-m8yRdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:50 INFO - Running setup.py (path:/tmp/pip-G6PlpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:50 INFO - Running setup.py (path:/tmp/pip-RaVU3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:50 INFO - Running setup.py (path:/tmp/pip-CutWF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:50 INFO - Running setup.py (path:/tmp/pip-byweK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:50 INFO - Running setup.py (path:/tmp/pip-THIFTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:50 INFO - Running setup.py (path:/tmp/pip-GBDKNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:50 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:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:50 INFO - Running setup.py (path:/tmp/pip-507mrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:51 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:28:51 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:28:51 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:28:51 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:28:51 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:28:51 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:28:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:52 INFO - Downloading blessings-1.5.1.tar.gz 22:28:52 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:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:28:52 INFO - Installing collected packages: blessings 22:28:52 INFO - Running setup.py install for blessings 22:28:52 INFO - Successfully installed blessings 22:28:52 INFO - Cleaning up... 22:28:52 INFO - Return code: 0 22:28:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:28:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:53 INFO - Reading from file tmpfile_stdout 22:28:53 INFO - Current package versions: 22:28:53 INFO - argparse == 1.2.1 22:28:53 INFO - blessings == 1.5.1 22:28:53 INFO - blobuploader == 1.2.4 22:28:53 INFO - docopt == 0.6.1 22:28:53 INFO - manifestparser == 1.1 22:28:53 INFO - mozInstall == 1.12 22:28:53 INFO - mozcrash == 0.16 22:28:53 INFO - mozdebug == 0.1 22:28:53 INFO - mozdevice == 0.47 22:28:53 INFO - mozfile == 1.2 22:28:53 INFO - mozhttpd == 0.7 22:28:53 INFO - mozinfo == 0.9 22:28:53 INFO - mozleak == 0.1 22:28:53 INFO - mozlog == 3.1 22:28:53 INFO - moznetwork == 0.27 22:28:53 INFO - mozprocess == 0.22 22:28:53 INFO - mozprofile == 0.28 22:28:53 INFO - mozrunner == 6.11 22:28:53 INFO - mozscreenshot == 0.1 22:28:53 INFO - mozsystemmonitor == 0.0 22:28:53 INFO - moztest == 0.7 22:28:53 INFO - mozversion == 1.4 22:28:53 INFO - psutil == 3.1.1 22:28:53 INFO - requests == 1.2.3 22:28:53 INFO - wsgiref == 0.1.2 22:28:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:53 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:28:53 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:28:53 INFO - Using env: {'DISPLAY': ':0', 22:28:53 INFO - 'HOME': '/home/cltbld', 22:28:53 INFO - 'LANG': 'en_US.UTF-8', 22:28:53 INFO - 'LANGUAGE': 'en_US:en', 22:28:53 INFO - 'LOGNAME': 'cltbld', 22:28:53 INFO - 'MAIL': '/var/mail/cltbld', 22:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:53 INFO - 'MOZ_NO_REMOTE': '1', 22:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:53 INFO - 'NO_EM_RESTART': '1', 22:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:53 INFO - 'PWD': '/builds/slave/test', 22:28:53 INFO - 'SHELL': '/bin/bash', 22:28:53 INFO - 'SHLVL': '1', 22:28:53 INFO - 'TERM': 'linux', 22:28:53 INFO - 'TMOUT': '86400', 22:28:53 INFO - 'USER': 'cltbld', 22:28:53 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:53 INFO - '_': '/tools/buildbot/bin/python'} 22:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:53 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:28:53 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:28:53 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:28:53 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:28:53 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:28:53 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:28:53 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:28:53 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:28:53 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:28:53 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:28:53 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:28:53 INFO - Cleaning up... 22:28:53 INFO - Return code: 0 22:28:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:28:53 INFO - Using env: {'DISPLAY': ':0', 22:28:53 INFO - 'HOME': '/home/cltbld', 22:28:53 INFO - 'LANG': 'en_US.UTF-8', 22:28:53 INFO - 'LANGUAGE': 'en_US:en', 22:28:53 INFO - 'LOGNAME': 'cltbld', 22:28:53 INFO - 'MAIL': '/var/mail/cltbld', 22:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:53 INFO - 'MOZ_NO_REMOTE': '1', 22:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:53 INFO - 'NO_EM_RESTART': '1', 22:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:53 INFO - 'PWD': '/builds/slave/test', 22:28:53 INFO - 'SHELL': '/bin/bash', 22:28:53 INFO - 'SHLVL': '1', 22:28:53 INFO - 'TERM': 'linux', 22:28:53 INFO - 'TMOUT': '86400', 22:28:53 INFO - 'USER': 'cltbld', 22:28:53 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:53 INFO - '_': '/tools/buildbot/bin/python'} 22:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:53 INFO - Downloading/unpacking jsonschema 22:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:28:55 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:28:55 INFO - Downloading/unpacking functools32 (from jsonschema) 22:28:55 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:55 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:55 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:55 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:55 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:55 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:55 INFO - Downloading functools32-3.2.3-2.tar.gz 22:28:55 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:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:28:55 INFO - warning: no files found matching '*.txt' 22:28:55 INFO - no previously-included directories found matching 'build' 22:28:55 INFO - no previously-included directories found matching 'dist' 22:28:55 INFO - no previously-included directories found matching '.git*' 22:28:55 INFO - Installing collected packages: jsonschema, functools32 22:28:55 INFO - Running setup.py install for functools32 22:28:55 INFO - warning: no files found matching '*.txt' 22:28:55 INFO - no previously-included directories found matching 'build' 22:28:55 INFO - no previously-included directories found matching 'dist' 22:28:55 INFO - no previously-included directories found matching '.git*' 22:28:55 INFO - Successfully installed jsonschema functools32 22:28:55 INFO - Cleaning up... 22:28:55 INFO - Return code: 0 22:28:55 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48ad6e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd31dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, '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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', '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', 'flake8'] 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 flake8 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': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 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 - Downloading/unpacking flake8 22:28:55 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:55 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:55 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:55 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:55 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:55 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 - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:28:57 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:28:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:28:57 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:57 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 - 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:57 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:57 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:57 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 - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:28:57 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:28:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:28:57 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:57 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 - 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:57 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:57 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:57 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 - 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:28:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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:28:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:28:58 INFO - no previously-included directories found matching 'docs/_build' 22:28:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:28:58 INFO - Running setup.py install for pep8 22:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:28:58 INFO - no previously-included directories found matching 'docs/_build' 22:28:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:28:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:28:58 INFO - Cleaning up... 22:28:58 INFO - Return code: 0 22:28:58 INFO - Running post-action listener: _resource_record_post_action 22:28:58 INFO - Running post-action listener: _start_resource_monitoring 22:28:58 INFO - Starting resource monitoring. 22:28:58 INFO - ##### 22:28:58 INFO - ##### Running install step. 22:28:58 INFO - ##### 22:28:58 INFO - Running pre-action listener: _resource_record_pre_action 22:28:58 INFO - Running main action method: install 22:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:58 INFO - Reading from file tmpfile_stdout 22:28:58 INFO - Detecting whether we're running mozinstall >=1.0... 22:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:28:58 INFO - Reading from file tmpfile_stdout 22:28:58 INFO - Output received: 22:28:58 INFO - Usage: mozinstall [options] installer 22:28:58 INFO - Options: 22:28:58 INFO - -h, --help show this help message and exit 22:28:58 INFO - -d DEST, --destination=DEST 22:28:58 INFO - Directory to install application into. [default: 22:28:58 INFO - "/builds/slave/test"] 22:28:58 INFO - --app=APP Application being installed. [default: firefox] 22:28:58 INFO - mkdir: /builds/slave/test/build/application 22:28:58 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:28:58 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:14 INFO - Reading from file tmpfile_stdout 22:29:14 INFO - Output received: 22:29:14 INFO - /builds/slave/test/build/application/firefox/firefox 22:29:14 INFO - Running post-action listener: _resource_record_post_action 22:29:14 INFO - ##### 22:29:14 INFO - ##### Running run-tests step. 22:29:14 INFO - ##### 22:29:14 INFO - Running pre-action listener: _resource_record_pre_action 22:29:14 INFO - Running main action method: run_tests 22:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:29:14 INFO - Python 2.7.3 22:29:14 INFO - Return code: 0 22:29:14 INFO - grabbing minidump binary from tooltool 22:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:14 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 0xdc43d0>, '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 0xd2fed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd30360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:29:14 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:14 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:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:29:14 INFO - Return code: 0 22:29:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:29:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:29:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:29:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:29:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:29:15 INFO - Return code: 0 22:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:29:15 INFO - Using env: {'DISPLAY': ':0', 22:29:15 INFO - 'HOME': '/home/cltbld', 22:29:15 INFO - 'LANG': 'en_US.UTF-8', 22:29:15 INFO - 'LANGUAGE': 'en_US:en', 22:29:15 INFO - 'LOGNAME': 'cltbld', 22:29:15 INFO - 'MAIL': '/var/mail/cltbld', 22:29:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:29:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:15 INFO - 'MOZ_NO_REMOTE': '1', 22:29:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:15 INFO - 'NO_EM_RESTART': '1', 22:29:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:15 INFO - 'PWD': '/builds/slave/test', 22:29:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:29:15 INFO - 'SHELL': '/bin/bash', 22:29:15 INFO - 'SHLVL': '1', 22:29:15 INFO - 'TERM': 'linux', 22:29:15 INFO - 'TMOUT': '86400', 22:29:15 INFO - 'USER': 'cltbld', 22:29:15 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932', 22:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:15 INFO - '_': '/tools/buildbot/bin/python'} 22:29:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/jKZ6ZkbiRROGsnt_ubO6Jw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:29:15 INFO - mozversion application_buildid: 20151229215139 22:29:15 INFO - mozversion application_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 22:29:15 INFO - mozversion application_display_name: Nightly 22:29:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:29:15 INFO - mozversion application_name: Firefox 22:29:15 INFO - mozversion application_remotingname: firefox 22:29:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:29:15 INFO - mozversion application_vendor: Mozilla 22:29:15 INFO - mozversion application_version: 46.0a1 22:29:15 INFO - mozversion platform_buildid: 20151229215139 22:29:15 INFO - mozversion platform_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 22:29:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:29:15 INFO - mozversion platform_version: 46.0a1 22:29:15 INFO - using testdate: 1451456955 22:29:15 INFO - actual date: 1451456955 22:29:15 INFO - starting webserver on 'localhost:53607' 22:29:15 INFO - SUITE-START | Running 3 tests 22:29:15 INFO - TEST-START | dromaeo_css 22:29:15 INFO - operating with platform_type : linux_ 22:29:15 INFO - Initialising browser for dromaeo_css test... 22:29:15 INFO - TEST-INFO | started process 26616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTLuvCh/profile http://localhost:53607/getInfo.html) 22:29:20 INFO - PROCESS | 26616 | __metrics Screen width/height:1600/1200 22:29:20 INFO - PROCESS | 26616 | colorDepth:24 22:29:20 INFO - PROCESS | 26616 | Browser inner width/height: 1024/697 22:29:20 INFO - PROCESS | 26616 | __metrics 22:29:20 INFO - PROCESS | 26616 | 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:21 INFO - TEST-INFO | 26616: exit 0 22:29:21 INFO - Browser initialized. 22:29:21 INFO - Running cycle 1/1 for dromaeo_css test... 22:29:21 INFO - TEST-INFO | started process 26747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTLuvCh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:29:33 INFO - PROCESS | 26747 | RSS: Main: 149479424 22:29:33 INFO - PROCESS | 26747 | 22:30:23 INFO - PROCESS | 26747 | 1451457023082 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:34 INFO - PROCESS | 26747 | Cycle 1(1): loaded http://localhost:53607/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53607/tests/dromaeo/cssquery-ext.html) 22:32:36 INFO - PROCESS | 26747 | RSS: Main: 155627520 22:32:36 INFO - PROCESS | 26747 | 22:35:38 INFO - PROCESS | 26747 | Cycle 1(1): loaded http://localhost:53607/tests/dromaeo/cssquery-ext.html (next: http://localhost:53607/tests/dromaeo/cssquery-jquery.html) 22:35:38 INFO - PROCESS | 26747 | RSS: Main: 152780800 22:35:38 INFO - PROCESS | 26747 | 22:38:40 INFO - PROCESS | 26747 | Cycle 1(1): loaded http://localhost:53607/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53607/tests/dromaeo/cssquery-mootools.html) 22:38:41 INFO - PROCESS | 26747 | RSS: Main: 153763840 22:38:41 INFO - PROCESS | 26747 | 22:41:42 INFO - PROCESS | 26747 | Cycle 1(1): loaded http://localhost:53607/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53607/tests/dromaeo/cssquery-prototype.html) 22:41:43 INFO - PROCESS | 26747 | RSS: Main: 152006656 22:41:43 INFO - PROCESS | 26747 | 22:44:46 INFO - PROCESS | 26747 | Cycle 1(1): loaded http://localhost:53607/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53607/tests/dromaeo/cssquery-yui.html) 22:44:46 INFO - PROCESS | 26747 | RSS: Main: 152023040 22:44:46 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | Cycle 1(1): loaded http://localhost:53607/tests/dromaeo/cssquery-yui.html (next: http://localhost:53607/tests/dromaeo/cssquery-dojo.html) 22:47:49 INFO - PROCESS | 26747 | RSS: Main: 154329088 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | __start_tp_report 22:47:49 INFO - PROCESS | 26747 | _x_x_mozilla_page_load 22:47:49 INFO - PROCESS | 26747 | _x_x_mozilla_page_load_details 22:47:49 INFO - PROCESS | 26747 | |i|pagename|runs| 22:47:49 INFO - PROCESS | 26747 | |0;dojo.html;2635.3279913622027;2714.1857442767164;2741.205050535345;2753.545664965281;2766.7509924106826;4610.538946105387;4678.438587369516;4716.151092803294;4726.7400292983875;4752.691075080117;4635.953640463595;4648.837290694826;4668.929966050512;4794.3767310249705;4804.471508134111;4318.460192475933;4392.428984232045;4456.777161141946;4464.955350446487;4494.056248187884;4418.204723149832;4426.579474949875;4429.800658970354;4438.933415998763;4523.502414734393;4257.808398622069;4333.393324934512;4406.162829062468;4416.447944006999;4477.820887164526;4348.412964249817;4434.977825110886;4447.5552444755585;4463.4420697412825;4466.977665111686;4316.2446571849805;4361.5856493633055;4363.890902727458;4376.452943382077;4396.56034396561;4420.20436321462;4561.954380456186;4564.497905230422;4577.908441831145;4656.32483289921;5121.795128194868;5133.435322114565;5145.614078944057;5147.459516750725;5154.098032844237;5150.948490515084;5187.377514698261;5188.688678679291;5193.143131383317;5230.843074707765;4561.475430325489;4666.8133274668635;4674.415698037746;4680.438347398334;4779.474257831635;5265.789368425297;5275.868103297448;5276.419593844674;5282.498162674539;5288.8413347599635;5046.318746969112;5071.163258062452;5077.619178561548;5079.060373830853;5110.310108135429;4889.804407823647;5034.043531728959;5062.493750624908;5141.920196758722;5167.22491626259;4945.381827271591;4965;4973.875653108629;5048.394192696826;5071.239314102841;4981.551660350586;4996.5003499650475;5003.649744517922;5007.148784706608;5063.088644044034;4147.730397524151;4240.215560121325;4240.660747140221;4297.634701050446;4340.804663790137;3715.869944551928;3717.312297224968;3719.1074142205675;3737.9626203738158;3739.7943113128495;4254.255505286563;4392.2752745797225;4393.077453734688;4405.911881762411;4420.359047938031;4993.700377977333;5073.036123136592;5144.176931690987;5152.330197074356;5188.169892817131;4360.760158191267;4370.453693288339;4418.55814418562;4425.867223983286;4454.933176002362;4342.32693932441;4449.13241917823;4528.298113792367;4531.320301954733;4558.635309175258;4703.45910220329;4812.783424745825;4830.154722923404;4842.055799119279;4877.292792545061;5103.77033033507;5137.101007323628;5143.202803565453;5146.228065790161;5151.433342332265;4713.222318317439;4824.662273640952;4825.3485779419325;4867.099586576494;4933.914538801458;4917.237828136645;4997.025580011863;5007.123753343078;5017.473165317735;5047.29337892688;5097.8725531862;5112.642115051911;5113;5121.436641969306;5164.122099243213;4746.501617330131;4847.927281090716;4894.902101958012;4955.975220123876;4956.702597843997;4960.77676504551;4962.255661650637;4978.377702787152;4979.153543897619;4985.651004429655;4844.249141383091;4849;4871.878203044952;4902.044101400335;4938.925916111333;4804.0872234275375;4910.508949105204;4915.65590408668;5026.773795179152;5083.2883396323805;4944.92582611254;4950.430700469492;4955.207166853286;4973.676711013773;4981.501849814989 22:47:49 INFO - PROCESS | 26747 | |1;ext.html;504.5030644814858;504.64422582079635;506.98732531686704;521.5175962234933;571.901948259342;32071.518927216082;32488.40092792577;32539.83730081352;32713.67286327136;32769.50845737316;35101.64898351016;35403.822980885125;35771.2845743085;35838.2832343353;35922.640773592255;7525.849483010336;7632.771016869503;7659.6936122555035;7678.117016543085;7688.846223075535;7478.990336304583;7522.736704215354;7582.582957937311;7603.2776886195725;7625.923740762577;7606.04924384452;7694.076710794712;7698.076230852277;7699.576523291216;7699.653515591812;7525.397968162534;7571.886421703679;7576.772696819076;7668.923310766877;7688.500247483951;7588.924110758932;7663.233676632348;7713.6914523419;7716.305532502046;7774.689012439496;35474;35521.82239088788;35710.64289357099;35777.46333804995;35911.28177436463;2706.91879243623;2728.9727102729116;2933.1054028521294;3326.96673033269;3396.456566949301;27272.31819204516;27402.314942126406;27555.448891022268;27908.720912790814;28047.719522804713;3247.951280730791;3283.5238890360765;3297.3570153820015;3345.531625572422;3363.764536482447;223163;224348;225560.99999999837;226189;226464;45874.5412545877;46482.8868824429;53414.465855341725;54723.72638136784;54933.72533137309;47502.76248618735;47519.287210691866;47657.28514072292;48066.5193348062;48095;11949.462274197682;12177.147599667938;12247.265164090182;12248.142630015991;12262.877371226174;8060.919390806134;8087.272145506932;8119.675212991414;8128.837423251502;8166.305864001626;18266.634667306844;18624.348147814762;18645.81354186441;18761.15574799137;18819.682622216587;7519.924800751923;7720.073591169095;7854.6858125674335;7858;7883;907.3059109781022;934.6354921580589;964.0744884910424;1036.7252678040325;1051.453244312953;25371.238862834143;25401.237962861145;25947.610785838227;25994.87002564975;26207.820648070883;921.7972046149837;977.1498796047342;979.5004547680592;987.5259875259771;1059.9311044782219;12281.324527150913;12423.44094515749;12516.74966500665;12578.622641320775;12615.404609686195;303257;313859;315803;316340;318764;45668.08663826705;46158;46302.305465418045;46365.768171158925;46527;1172.536847945057;1178.4579093617033;1186.768580126867;1188.8454500914825;1199.7300607363272;23398.883005584863;29635.407291854473;30396.240093997825;30566.1413979968;31127.533087004165;41888.3716744243;42289;42610;42665.786671066446;42781.78609106935;244833;247230;247738;248849;249358;37172.25655486821;37779;37848.81075594604;37989.24021519499;38368;34025.65974340225;38007.619923800405;38151.42772858354;38209.04477388087;38582.80708596551;30913.69086309108;31537.684623153476;31989;32187.195320117185;32434.21611811373;32888.177795554344;32971.67028329686;34211.605187636625;36056.63943360533;36234.637653623126;30337.24156896095;33959.83020084884;34936.475952861234;35124;35176.47235291524;25832.483350333263;27686;27728.168154955383;27972.860135699193;28201;21742.891285543472;23515.294541163792;23574.88212558926;23575;23761.762382375953 22:47:49 INFO - PROCESS | 26747 | |2;jquery.html;334.785737128238;334.97990120592766;336.90566641340433;338.0787354459098;338.5024014698393;14453.060551064187;14803.555893323191;15441.613959651015;15633.843661563382;16063.518094457186;14733.557993260192;14790.85209147911;15043.548693539184;15092.868034897372;15105.77341339878;4217.346311321742;4562.224421848277;4573.542645735433;4577.107464044512;4581.633469322446;4977.950220497803;5004.699718016931;5024.899502009957;5038.722870242135;5039.344885164942;4780;4871.318015477836;4928.334674818907;4943.950560494403;4982.651214414992;4849.539293767104;4917.901641967176;4919.843836698373;4940.209566469365;5218.947810521884;5041.546260836542;5044.621653375974;5080.263361812554;5091.745412729349;5093.592512598983;10852.891471085268;10896.618618348399;14026.789598156036;18782.436526904214;18818.623627527373;1612.5001249612658;1659.7551736512562;1667.25807015878;1709.4102534625658;1717.690815653182;8524.78688032798;8689.17452841979;8853.867191992125;8998.55007249635;9380.765480862965;1634.1584084196647;1648.8021437427585;1718.1789289686874;1720.4494561740248;1790.444962061752;54324.45675543234;55936.72031639856;56081.43918560844;57312.426875731544;58155.41844581585;9470.242380609672;9646.855297170549;9924.354916930377;9945.552450139761;9955.303128780915;12608.558700445441;12610;12613.936930315473;12616.36918154107;12658.62024139259;6104.114903338991;6279.654618995999;6456.451201647818;6494.1232933553365;6508.576942498722;5975.910361344583;6062.878742425127;6089.269287685506;6105.267367915879;6132.754689812357;3889.199217970698;3918.647321741;4111.60939710727;4199.496060472702;4270.274053410928;1694.1867903406187;1761.3923196497187;1780.6883795336023;1792.8386445219992;1818.8453981411728;357.4887910288261;359.69605683197653;363.0560542589247;364.2569158915835;387.656923622596;9170.770730731785;9336.719898403058;9526.571304291185;9540.141387275178;9649.469279189712;371.35199077609747;379.90122568132483;381.3326678312952;385.41801879162665;393.0998014546713;5298;5321.201819727072;5352.330958630171;5407.864803379947;5431.6740995540395;310376;315739;318228;536448;536704;35259.82370088133;48947.02105957861;58420.7078964611;59986.40013599808;60260.397396026354;972.4262685015733;1008.7276435362411;1011.3881101933372;1014.7158795537409;1016.1261315269011;14585.416583336548;14587;14587.520121579144;14798.96407251482;15120.924395377953;30996.845015775678;31292.061238162893;31843.20391990219;32289.192770180933;32403.837980809945;40938.385924211754;41388.79305603453;41914.58085419107;43028.56971430371;44056.77971610121;8342.582870856555;8454.577271136295;8502.914970850212;8509.489430634181;8567.91432085696;9723.513824308615;9861.359011664219;15050.774238386213;15899.205039748198;15964.20178991069;11851;12777.616671499869;13225.537106201236;13322.33388330599;13662.11196272239;12937.223766574036;13098.672533186365;13318.733625327633;13399.397027133607;13410.32948352559;13538.390772415069;13954.58136255914;14325.57023289303;14431.278436077944;14496;8507.82984340322;8670.089640587648;8686.52224127679;8834.249088827522;8857.247133993682;13503.054786164874;13616.65958351049;13637;13954.162750235018;14144.43422263098 22:47:49 INFO - PROCESS | 26747 | |3;mootools.html;1305.706216101377;1367.200187890084;1449.9710005799884;1684.5788552861784;1688.1306127344412;5920;5978.491828194608;7042.683079261433;7161.104861892263;7163.964180179092;6724.899126513106;6888.276730943254;6891.689873955672;6940.6876690548925;6968.442524598033;2081.0427203486374;2110.05047728522;2123.936281911537;2125.064971412581;2125.5642593268344;2125.3305208859238;2127.2448280860303;2151.4191168384527;2154.278316763886;2160.82713382929;2082.063071617778;2087.65553683642;2090.383336915606;2116.502621883856;2117.978820211801;2090.216168936649;2100.779418161094;2108.7891210878943;2110.9788902110936;2120.8409369297365;2076.3148161106797;2119.279444988696;2119.79861913118;2125.6705210692367;2144.721186245794;7044.15470143586;7054.294570542956;7063.081799366049;7161.069061022086;7168.60572668503;4036.535798383165;4122.505299364066;4132.793360331972;4145.067359844041;4156.9792151039055;2821.8730157142977;2831.3346363604537;2946.6169397978124;2951.9557206641916;2954.4829654810324;890.0876601483467;913.7943962608426;928.6749637626845;939.6335429182556;942.1285311087286;9323.953380233123;9386.389884657543;9421.764455888657;9477.905220947703;9482.288828337902;3880.3597406427625;3890;3904.882853514399;3964.226975739703;3966.1076257841755;8191.8771218431775;8203.220694034057;8234.588270586446;8258.876116858251;8268.545230012407;4250.851220207278;4276.102018576072;4299.312110062375;4309.892252693645;4321.2653848845775;3735.234276973214;3850.8074596270076;3862.4978752761963;3896.5518965318784;3916.6279203475624;3264.1676372524853;3267.379197952381;3268.3953468608383;3290;3303.421901167334;977.413551868873;982.4645568165367;986.1272773595276;1009.1422291052546;1011.7723512209841;874.606427107804;874.6588830356167;883.6200433813522;1096.2326371539793;1102.735343517566;6675.165604299463;6692.397684208445;6765.797026089225;6783.966080169666;6792.0830687856505;407.0515698422668;407.69015548183;410.4848415238856;412.23530351198696;412.5523806669737;5149;5198.532132108128;5258.342707161605;5264.815731449381;5265.078611243017;8324.959380077491;8478.23695867375;8575.185357391163;8575.3997220194;8627.309815214894;8221.136780638066;8330.458520196167;8333.916660833434;8347.833043339098;8470.322374210049;6688.331166883273;6694.096296999843;6705.932940670628;6718.731250750013;6729.360710732472;6163.506919446523;6219.191505104489;6314.652694101868;6322.589031712924;6338.461230795434;7469.925300746923;7519.924800751923;7565.470417070752;7662.540247585162;7667.463277570517;7274.127104747464;7354.264573542603;7374.6681399336085;7408.888866667112;7490.325870671666;5404.243405923095;5460.836174914759;6100.389961004042;6114.6942652868065;6236.688165591611;6448.484121270381;6488.156539649815;6537.5750576212395;6545.672716364067;6558.901616475852;5882.647041177543;5967.6419414835245;6008.699565021819;6009.128676341993;6079.908801368071;5828.679422631796;5874.236349274567;5899.941000589939;5965.9105113422465;5981.312149102909;5959.344472108151;5987.64074155552;6069.817905462844;6203.379662033761;6232.563720539519;5762.711864406847;5803.187553742395;5804.187413762161;5817.243758311392;5822.359540450631;5914.556408269311;5935.465808077293;5944.613600115978;6003.849903752266;6012.3085845126625 22:47:49 INFO - PROCESS | 26747 | |4;prototype.html;293.8427941051537;302.9970796663045;310.3002728846454;310.5000948472958;313.7772181750957;5512.228288039678;5513.58648101392;5523.061079616465;5568.66588004719;5674.460926212014;5513.3108361454815;5546.86132846679;5558.833235002957;5570.944290557103;5582.218489411485;4229.873103806891;4252.702310838243;4262.850800221993;4269.210196113713;4275.42281791958;4253.191893540217;4261.275583150872;4277.165952639237;4286.678499112563;4292.957070429303;4116;4164.042270277838;4168.145530166324;4251.59609837065;4258.659307255412;4223.36649502574;4224.471941007374;4232.724872883253;4238.851640192578;4250.319948808191;3676.5036720042717;3686.3364594373;3689.6679298863232;3691.8370713225518;3704.1665625234377;5263.815766448194;5269.156934890438;5270.1040823060175;5274.683518988834;5276.868078298035;4666.556677115668;4789.233722604366;4884.560389564921;4901.950980490221;4909.337239472697;5854.97072514639;5859.824205273806;5862.443067908584;5867.559933005042;5871.970640146815;4010.7994600270163;4023.6177563131455;4028.8992775180564;4033.253848038122;4041.8585349512628;6073.635581865102;6146.016637338049;6156.999999999955;6164.321924588292;6167.5682702210415;4009.1981603679383;4110.260153172458;4115.670746340285;4140.896477588024;4142.316517774594;4142.378643203483;4160.334346504545;4199.265128602544;4202.054537728986;4211.410402543646;4812.5668689817385;4871.585915197248;4871.683340582851;4879.682820616648;4892.902141957141;5815.185873977646;5857.150713146655;5861.677607731615;5871.031279838864;5871.32479764824;1466.4354223623768;1494.880409567232;1501.3919362658141;1507.6457032597332;1538.7076455473425;1037.4397825174321;1050.7110544600296;1053.2153545608417;1059.9841002384971;1069.6256310291335;5071.137906555894;5107.7446127693465;5116.488351164854;5124.359455068116;5137.666051706702;6032.39676032402;6044.274687037584;6059.787907423219;6070.7875224366935;6075.544334174954;5090.0583392072585;5110.182370820651;5124.92312615311;5126.38483381989;5137.717425541631;3192.0902542775198;3216.887408940676;3258.8207648579555;3271.116798464401;3278.868845246211;5718.142278658152;5719.828405147852;5723.284589426322;5726.169705392695;5727.6849773262875;6143.1706719592285;6178.69106544671;6200.3179650238435;6212.81361559154;6213.782517611862;5578.382269141985;5619.606627536034;5716.828495145152;5719.084946408555;5720.942790572124;6151.5386346025125;6159.538034647329;6166.969165154145;6168;6169.413905678954;5968.343482217039;5981.940180598138;5987.31145918225;5993.910091348721;5994.430529099728;5605.691686957257;5774.105013722879;5798.043322851682;5807.157962095557;5816.41835816415;4308.4399028126145;4308.784560772012;4314.460692413449;4314.870553883388;4320.848770293024;6141.263048434216;6152.446279834837;6155.2921414037955;6157.753689852535;6159.4456498915315;5872.354041055566;5912.083627037816;5914.2311499504785;5921.61509501881;5925.733341999707;5749.310082790092;5823;5885.440883116097;5900.557458190567;5921.259842519685;5703.543716502587;5728.627639203439;5737.282839645044;5762.1068734346245;5764.711764411846;5900.822975310576;5910;5921.674307912934;5922.378150294329;5939.792107276225;5655.1517272409465;5777.508911742549;5793.623414478214;5799.4780469757925;5799.884002320015 22:47:49 INFO - PROCESS | 26747 | |5;yui.html;703.9859202815943;711.4237467651203;720.2221600671276;740.6815069520104;746.1605693594706;10811.189160812932;10833.349999000066;11001.284916480423;11008.559657613696;11043.619547556555;10918.727031824208;10997.395143267117;11114.888851111486;11127.499262533185;11179.720506987309;747.6224506624147;757.5719718359137;767.4282659418741;768.0974854545914;774.7133560582593;761.5659074327608;766.7316439246247;767.6775754183257;770.6801677303912;772.2162005564329;798.7723498802842;805.5005896344245;808.8786681997718;811.4847072109194;812.5733989655448;795.3915254830031;798.7244400681756;801.3068695578341;802.4663598706853;802.8675268580677;589.8171566814301;592.973316200772;593.1103344982527;594.2631137389649;595.0865421577901;10121.645742398981;10190.59237630494;10221;10238.795224095476;10242.9487852561;9995.25035622324;10761.946190268998;10848.294860834021;11224.214304998653;11300.434978251054;9116.544172791333;9131.589078491485;9364.110409511153;9473.905260947371;9518.238540916711;3166.936661266785;3224.467962786161;3238.465653167248;3279.0490757680245;3286.819224942627;39946.201075978606;40330.79834600838;40369.19261614751;40449.79775101106;40488.79755601232;8646.481211127353;8853.424527405698;8881.467111973174;9022.278217742565;9033.593488293043;15819.52541423759;15825.446109386115;15827.52517424479;15841.603959900864;15870.44453444124;5976.133460648269;6006.909896351558;6042.516598672096;6050.183225264533;6108.1143234230785;3352.966470335314;3395.0833275015607;3424.760266781351;3443.9483407748903;3449.6722811333384;2980.195347256272;3039.149038269288;3059.7705172111737;3066.018873960356;3076.984615076955;499.2910067703797;511.6827566908466;516.7442116152529;518.7095226673075;520.3911423634357;387.54657051250103;404.5711545761502;406.7295248659667;417.67838764151435;426.6608046602958;6245.500359971192;6719.294474080249;6828.283030281848;6900.102986611709;6987.650617469106;418.374530077536;459.3064472646328;488.9731064791471;540.3839622829977;551.2145193099817;3140.890068847579;3149.33863888586;3163.430582495173;3178.6503484616674;3243.156779237368;48524.27213591799;48666.513334866904;48705.5129448708;48820.75589622029;51630.48369516257;42449;42452;43033.13933721371;43081.35377969333;43288.13423731508;42567.787161064;44679;44875.775621121684;45272.54727452749;45879.77060114678;7019.789406317818;7172.450661558197;7176.318249766264;7288.453365997678;7360.668769905475;31429.214269643442;31656.683433166294;31965.24191169508;32185.67814321827;33160;38076.23847522979;38470.42294365531;39553.604463956144;40015.599844002354;40228;10170;10474.266801324138;10529.315594486334;11291.774164516499;11309;10959.945200273947;11074.778504430027;11350.148738844455;11420.086393088699;11715.941420292844;9773.218142548722;9807.460589667637;10250.333728307636;10548.630797922036;10662.360258384522;9613.327067105236;10300.742481438025;10329.12202462799;10607.840882386616;10841.078508326565;9161;9450.054994500495;9543.665971690958;9699.9030009699;9712.417254964725;9504.667336643184;9546;9626.518674066128;9747.805043898941;10105.343152695052;8817.509210907321;8834.116588341114;8875.156860098281;9114.40756350835;9131.886727466055 22:47:49 INFO - PROCESS | 26747 | __end_tp_report 22:47:49 INFO - PROCESS | 26747 | __start_cc_report 22:47:49 INFO - PROCESS | 26747 | _x_x_mozilla_cycle_collect,322 22:47:49 INFO - PROCESS | 26747 | __end_cc_report 22:47:49 INFO - PROCESS | 26747 | __startTimestamp1451458069415__endTimestamp 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | ------- Summary: start ------- 22:47:49 INFO - PROCESS | 26747 | Number of tests: 6 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | [#0] dojo.html Cycles:165 Average:4698.69 Median:4830.15 stddev:493.82 (10.2%) stddev-sans-first:468.05 22:47:49 INFO - PROCESS | 26747 | Values: 2635.3 2714.2 2741.2 2753.5 2766.8 4610.5 4678.4 4716.2 4726.7 4752.7 4636.0 4648.8 4668.9 4794.4 4804.5 4318.5 4392.4 4456.8 4465.0 4494.1 4418.2 4426.6 4429.8 4438.9 4523.5 4257.8 4333.4 4406.2 4416.4 4477.8 4348.4 4435.0 4447.6 4463.4 4467.0 4316.2 4361.6 4363.9 4376.5 4396.6 4420.2 4562.0 4564.5 4577.9 4656.3 5121.8 5133.4 5145.6 5147.5 5154.1 5150.9 5187.4 5188.7 5193.1 5230.8 4561.5 4666.8 4674.4 4680.4 4779.5 5265.8 5275.9 5276.4 5282.5 5288.8 5046.3 5071.2 5077.6 5079.1 5110.3 4889.8 5034.0 5062.5 5141.9 5167.2 4945.4 4965.0 4973.9 5048.4 5071.2 4981.6 4996.5 5003.6 5007.1 5063.1 4147.7 4240.2 4240.7 4297.6 4340.8 3715.9 3717.3 3719.1 3738.0 3739.8 4254.3 4392.3 4393.1 4405.9 4420.4 4993.7 5073.0 5144.2 5152.3 5188.2 4360.8 4370.5 4418.6 4425.9 4454.9 4342.3 4449.1 4528.3 4531.3 4558.6 4703.5 4812.8 4830.2 4842.1 4877.3 5103.8 5137.1 5143.2 5146.2 5151.4 4713.2 4824.7 4825.3 4867.1 4933.9 4917.2 4997.0 5007.1 5017.5 5047.3 5097.9 5112.6 5113.0 5121.4 5164.1 4746.5 4847.9 4894.9 4956.0 4956.7 4960.8 4962.3 4978.4 4979.2 4985.7 4844.2 4849.0 4871.9 4902.0 4938.9 4804.1 4910.5 4915.7 5026.8 5083.3 4944.9 4950.4 4955.2 4973.7 4981.5 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | [#1] ext.html Cycles:180 Average:41488.35 Median:35112.82 stddev:69256.16 (197.2%) stddev-sans-first:69382.08 22:47:49 INFO - PROCESS | 26747 | Values: 504.5 504.6 507.0 521.5 571.9 32071.5 32488.4 32539.8 32713.7 32769.5 35101.6 35403.8 35771.3 35838.3 35922.6 7525.8 7632.8 7659.7 7678.1 7688.8 7479.0 7522.7 7582.6 7603.3 7625.9 7606.0 7694.1 7698.1 7699.6 7699.7 7525.4 7571.9 7576.8 7668.9 7688.5 7588.9 7663.2 7713.7 7716.3 7774.7 35474.0 35521.8 35710.6 35777.5 35911.3 2706.9 2729.0 2933.1 3327.0 3396.5 27272.3 27402.3 27555.4 27908.7 28047.7 3248.0 3283.5 3297.4 3345.5 3363.8 223163.0 224348.0 225561.0 226189.0 226464.0 45874.5 46482.9 53414.5 54723.7 54933.7 47502.8 47519.3 47657.3 48066.5 48095.0 11949.5 12177.1 12247.3 12248.1 12262.9 8060.9 8087.3 8119.7 8128.8 8166.3 18266.6 18624.3 18645.8 18761.2 18819.7 7519.9 7720.1 7854.7 7858.0 7883.0 907.3 934.6 964.1 1036.7 1051.5 25371.2 25401.2 25947.6 25994.9 26207.8 921.8 977.1 979.5 987.5 1059.9 12281.3 12423.4 12516.7 12578.6 12615.4 303257.0 313859.0 315803.0 316340.0 318764.0 45668.1 46158.0 46302.3 46365.8 46527.0 1172.5 1178.5 1186.8 1188.8 1199.7 23398.9 29635.4 30396.2 30566.1 31127.5 41888.4 42289.0 42610.0 42665.8 42781.8 244833.0 247230.0 247738.0 248849.0 249358.0 37172.3 37779.0 37848.8 37989.2 38368.0 34025.7 38007.6 38151.4 38209.0 38582.8 30913.7 31537.7 31989.0 32187.2 32434.2 32888.2 32971.7 34211.6 36056.6 36234.6 30337.2 33959.8 34936.5 35124.0 35176.5 25832.5 27686.0 27728.2 27972.9 28201.0 21742.9 23515.3 23574.9 23575.0 23761.8 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | [#2] jquery.html Cycles:180 Average:22917.76 Median:3903.92 stddev:68338.97 (1750.5%) stddev-sans-first:68509.64 22:47:49 INFO - PROCESS | 26747 | Values: 334.8 335.0 336.9 338.1 338.5 14453.1 14803.6 15441.6 15633.8 16063.5 14733.6 14790.9 15043.5 15092.9 15105.8 4217.3 4562.2 4573.5 4577.1 4581.6 4978.0 5004.7 5024.9 5038.7 5039.3 4780.0 4871.3 4928.3 4944.0 4982.7 4849.5 4917.9 4919.8 4940.2 5218.9 5041.5 5044.6 5080.3 5091.7 5093.6 10852.9 10896.6 14026.8 18782.4 18818.6 1612.5 1659.8 1667.3 1709.4 1717.7 8524.8 8689.2 8853.9 8998.6 9380.8 1634.2 1648.8 1718.2 1720.4 1790.4 54324.5 55936.7 56081.4 57312.4 58155.4 9470.2 9646.9 9924.4 9945.6 9955.3 12608.6 12610.0 12613.9 12616.4 12658.6 6104.1 6279.7 6456.5 6494.1 6508.6 5975.9 6062.9 6089.3 6105.3 6132.8 3889.2 3918.6 4111.6 4199.5 4270.3 1694.2 1761.4 1780.7 1792.8 1818.8 357.5 359.7 363.1 364.3 387.7 9170.8 9336.7 9526.6 9540.1 9649.5 371.4 379.9 381.3 385.4 393.1 5298.0 5321.2 5352.3 5407.9 5431.7 310376.0 315739.0 318228.0 536448.0 536704.0 35259.8 48947.0 58420.7 59986.4 60260.4 972.4 1008.7 1011.4 1014.7 1016.1 14585.4 14587.0 14587.5 14799.0 15120.9 30996.8 31292.1 31843.2 32289.2 32403.8 40938.4 41388.8 41914.6 43028.6 44056.8 8342.6 8454.6 8502.9 8509.5 8567.9 9723.5 9861.4 15050.8 15899.2 15964.2 11851.0 12777.6 13225.5 13322.3 13662.1 12937.2 13098.7 13318.7 13399.4 13410.3 13538.4 13954.6 14325.6 14431.3 14496.0 8507.8 8670.1 8686.5 8834.2 8857.2 13503.1 13616.7 13637.0 13954.2 14144.4 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | [#3] mootools.html Cycles:180 Average:4858.74 Median:5966.78 stddev:2515.66 (42.2%) stddev-sans-first:2508.54 22:47:49 INFO - PROCESS | 26747 | Values: 1305.7 1367.2 1450.0 1684.6 1688.1 5920.0 5978.5 7042.7 7161.1 7164.0 6724.9 6888.3 6891.7 6940.7 6968.4 2081.0 2110.1 2123.9 2125.1 2125.6 2125.3 2127.2 2151.4 2154.3 2160.8 2082.1 2087.7 2090.4 2116.5 2118.0 2090.2 2100.8 2108.8 2111.0 2120.8 2076.3 2119.3 2119.8 2125.7 2144.7 7044.2 7054.3 7063.1 7161.1 7168.6 4036.5 4122.5 4132.8 4145.1 4157.0 2821.9 2831.3 2946.6 2952.0 2954.5 890.1 913.8 928.7 939.6 942.1 9324.0 9386.4 9421.8 9477.9 9482.3 3880.4 3890.0 3904.9 3964.2 3966.1 8191.9 8203.2 8234.6 8258.9 8268.5 4250.9 4276.1 4299.3 4309.9 4321.3 3735.2 3850.8 3862.5 3896.6 3916.6 3264.2 3267.4 3268.4 3290.0 3303.4 977.4 982.5 986.1 1009.1 1011.8 874.6 874.7 883.6 1096.2 1102.7 6675.2 6692.4 6765.8 6784.0 6792.1 407.1 407.7 410.5 412.2 412.6 5149.0 5198.5 5258.3 5264.8 5265.1 8325.0 8478.2 8575.2 8575.4 8627.3 8221.1 8330.5 8333.9 8347.8 8470.3 6688.3 6694.1 6705.9 6718.7 6729.4 6163.5 6219.2 6314.7 6322.6 6338.5 7469.9 7519.9 7565.5 7662.5 7667.5 7274.1 7354.3 7374.7 7408.9 7490.3 5404.2 5460.8 6100.4 6114.7 6236.7 6448.5 6488.2 6537.6 6545.7 6558.9 5882.6 5967.6 6008.7 6009.1 6079.9 5828.7 5874.2 5899.9 5965.9 5981.3 5959.3 5987.6 6069.8 6203.4 6232.6 5762.7 5803.2 5804.2 5817.2 5822.4 5914.6 5935.5 5944.6 6003.8 6012.3 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | [#4] prototype.html Cycles:180 Average:4845.59 Median:5512.77 stddev:1436.24 (26.1%) stddev-sans-first:1399.05 22:47:49 INFO - PROCESS | 26747 | Values: 293.8 303.0 310.3 310.5 313.8 5512.2 5513.6 5523.1 5568.7 5674.5 5513.3 5546.9 5558.8 5570.9 5582.2 4229.9 4252.7 4262.9 4269.2 4275.4 4253.2 4261.3 4277.2 4286.7 4293.0 4116.0 4164.0 4168.1 4251.6 4258.7 4223.4 4224.5 4232.7 4238.9 4250.3 3676.5 3686.3 3689.7 3691.8 3704.2 5263.8 5269.2 5270.1 5274.7 5276.9 4666.6 4789.2 4884.6 4902.0 4909.3 5855.0 5859.8 5862.4 5867.6 5872.0 4010.8 4023.6 4028.9 4033.3 4041.9 6073.6 6146.0 6157.0 6164.3 6167.6 4009.2 4110.3 4115.7 4140.9 4142.3 4142.4 4160.3 4199.3 4202.1 4211.4 4812.6 4871.6 4871.7 4879.7 4892.9 5815.2 5857.2 5861.7 5871.0 5871.3 1466.4 1494.9 1501.4 1507.6 1538.7 1037.4 1050.7 1053.2 1060.0 1069.6 5071.1 5107.7 5116.5 5124.4 5137.7 6032.4 6044.3 6059.8 6070.8 6075.5 5090.1 5110.2 5124.9 5126.4 5137.7 3192.1 3216.9 3258.8 3271.1 3278.9 5718.1 5719.8 5723.3 5726.2 5727.7 6143.2 6178.7 6200.3 6212.8 6213.8 5578.4 5619.6 5716.8 5719.1 5720.9 6151.5 6159.5 6167.0 6168.0 6169.4 5968.3 5981.9 5987.3 5993.9 5994.4 5605.7 5774.1 5798.0 5807.2 5816.4 4308.4 4308.8 4314.5 4314.9 4320.8 6141.3 6152.4 6155.3 6157.8 6159.4 5872.4 5912.1 5914.2 5921.6 5925.7 5749.3 5823.0 5885.4 5900.6 5921.3 5703.5 5728.6 5737.3 5762.1 5764.7 5900.8 5910.0 5921.7 5922.4 5939.8 5655.2 5777.5 5793.6 5799.5 5799.9 22:47:49 INFO - PROCESS | 26747 | 22:47:49 INFO - PROCESS | 26747 | [#5] yui.html Cycles:180 Average:12084.16 Median:45074.16 stddev:13965.22 (31.0%) stddev-sans-first:13978.24 22:47:49 INFO - PROCESS | 26747 | Values: 704.0 711.4 720.2 740.7 746.2 10811.2 10833.3 11001.3 11008.6 11043.6 10918.7 10997.4 11114.9 11127.5 11179.7 747.6 757.6 767.4 768.1 774.7 761.6 766.7 767.7 770.7 772.2 798.8 805.5 808.9 811.5 812.6 795.4 798.7 801.3 802.5 802.9 589.8 593.0 593.1 594.3 595.1 10121.6 10190.6 10221.0 10238.8 10242.9 9995.3 10761.9 10848.3 11224.2 11300.4 9116.5 9131.6 9364.1 9473.9 9518.2 3166.9 3224.5 3238.5 3279.0 3286.8 39946.2 40330.8 40369.2 40449.8 40488.8 8646.5 8853.4 8881.5 9022.3 9033.6 15819.5 15825.4 15827.5 15841.6 15870.4 5976.1 6006.9 6042.5 6050.2 6108.1 3353.0 3395.1 3424.8 3443.9 3449.7 2980.2 3039.1 3059.8 3066.0 3077.0 499.3 511.7 516.7 518.7 520.4 387.5 404.6 406.7 417.7 426.7 6245.5 6719.3 6828.3 6900.1 6987.7 418.4 459.3 489.0 540.4 551.2 3140.9 3149.3 3163.4 3178.7 3243.2 48524.3 48666.5 48705.5 48820.8 51630.5 42449.0 42452.0 43033.1 43081.4 43288.1 42567.8 44679.0 44875.8 45272.5 45879.8 7019.8 7172.5 7176.3 7288.5 7360.7 31429.2 31656.7 31965.2 32185.7 33160.0 38076.2 38470.4 39553.6 40015.6 40228.0 10170.0 10474.3 10529.3 11291.8 11309.0 10959.9 11074.8 11350.1 11420.1 11715.9 9773.2 9807.5 10250.3 10548.6 10662.4 9613.3 10300.7 10329.1 10607.8 10841.1 9161.0 9450.1 9543.7 9699.9 9712.4 9504.7 9546.0 9626.5 9747.8 10105.3 8817.5 8834.1 8875.2 9114.4 9131.9 22:47:49 INFO - PROCESS | 26747 | -------- Summary: end -------- 22:47:49 INFO - PROCESS | 26747 | 22:47:50 INFO - TEST-INFO | 26747: exit 0 22:47:50 INFO - TEST-OK | dromaeo_css | took 1114578ms 22:47:50 INFO - TEST-START | kraken 22:47:50 INFO - operating with platform_type : linux_ 22:47:50 INFO - Initialising browser for kraken test... 22:47:50 INFO - TEST-INFO | started process 26990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIObQuw/profile http://localhost:53607/getInfo.html) 22:47:54 INFO - PROCESS | 26990 | __metrics Screen width/height:1600/1200 22:47:54 INFO - PROCESS | 26990 | colorDepth:24 22:47:54 INFO - PROCESS | 26990 | Browser inner width/height: 1024/697 22:47:54 INFO - PROCESS | 26990 | __metrics 22:47:54 INFO - PROCESS | 26990 | 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:47:55 INFO - TEST-INFO | 26990: exit 0 22:47:55 INFO - Browser initialized. 22:47:55 INFO - Running cycle 1/1 for kraken test... 22:47:55 INFO - TEST-INFO | started process 27110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIObQuw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:07 INFO - PROCESS | 27110 | RSS: Main: 150183936 22:48:07 INFO - PROCESS | 27110 | 22:48:10 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53607/tests/kraken/driver.html?testName=audio-beat-detection) 22:48:11 INFO - PROCESS | 27110 | RSS: Main: 150634496 22:48:11 INFO - PROCESS | 27110 | 22:48:13 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53607/tests/kraken/driver.html?testName=audio-dft) 22:48:14 INFO - PROCESS | 27110 | RSS: Main: 149950464 22:48:14 INFO - PROCESS | 27110 | 22:48:17 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53607/tests/kraken/driver.html?testName=audio-fft) 22:48:17 INFO - PROCESS | 27110 | RSS: Main: 145129472 22:48:17 INFO - PROCESS | 27110 | 22:48:19 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53607/tests/kraken/driver.html?testName=audio-oscillator) 22:48:20 INFO - PROCESS | 27110 | RSS: Main: 145956864 22:48:20 INFO - PROCESS | 27110 | 22:48:22 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53607/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:48:23 INFO - PROCESS | 27110 | RSS: Main: 146296832 22:48:23 INFO - PROCESS | 27110 | 22:48:26 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53607/tests/kraken/driver.html?testName=imaging-darkroom) 22:48:27 INFO - PROCESS | 27110 | RSS: Main: 146763776 22:48:27 INFO - PROCESS | 27110 | 22:48:30 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53607/tests/kraken/driver.html?testName=imaging-desaturate) 22:48:31 INFO - PROCESS | 27110 | RSS: Main: 145686528 22:48:31 INFO - PROCESS | 27110 | 22:48:34 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53607/tests/kraken/driver.html?testName=json-parse-financial) 22:48:34 INFO - PROCESS | 27110 | RSS: Main: 146030592 22:48:34 INFO - PROCESS | 27110 | 22:48:36 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53607/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:48:36 INFO - PROCESS | 27110 | RSS: Main: 148529152 22:48:36 INFO - PROCESS | 27110 | 22:48:38 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:48:39 INFO - PROCESS | 27110 | RSS: Main: 147255296 22:48:39 INFO - PROCESS | 27110 | 22:48:41 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:48:42 INFO - PROCESS | 27110 | RSS: Main: 147398656 22:48:42 INFO - PROCESS | 27110 | 22:48:44 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:48:45 INFO - PROCESS | 27110 | RSS: Main: 147378176 22:48:45 INFO - PROCESS | 27110 | 22:48:48 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:48:48 INFO - PROCESS | 27110 | RSS: Main: 147316736 22:48:48 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | Cycle 1(1): loaded http://localhost:53607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53607/tests/kraken/driver.html?testName=ai-astar) 22:48:50 INFO - PROCESS | 27110 | RSS: Main: 147488768 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | __start_tp_report 22:48:50 INFO - PROCESS | 27110 | _x_x_mozilla_page_load 22:48:50 INFO - PROCESS | 27110 | _x_x_mozilla_page_load_details 22:48:50 INFO - PROCESS | 27110 | |i|pagename|runs| 22:48:50 INFO - PROCESS | 27110 | |0;ai-astar;113;109;113;114;113;125;114;114;113;114 22:48:50 INFO - PROCESS | 27110 | |1;audio-beat-detection;156;131;154;165;133;155;168;137;172;137 22:48:50 INFO - PROCESS | 27110 | |2;audio-dft;164;164;164;162;162;166;172;164;164;163 22:48:50 INFO - PROCESS | 27110 | |3;audio-fft;72;75;72;74;137;72;74;73;72;91 22:48:50 INFO - PROCESS | 27110 | |4;audio-oscillator;96;100;136;97;102;98;141;98;98;134 22:48:50 INFO - PROCESS | 27110 | |5;imaging-gaussian-blur;109;110;109;110;114;113;110;110;110;110 22:48:50 INFO - PROCESS | 27110 | |6;imaging-darkroom;148;147;148;148;148;148;148;147;148;148 22:48:50 INFO - PROCESS | 27110 | |7;imaging-desaturate;96;96;98;96;97;97;98;97;96;96 22:48:50 INFO - PROCESS | 27110 | |8;json-parse-financial;71;71;70;71;72;71;69;70;71;75 22:48:50 INFO - PROCESS | 27110 | |9;json-stringify-tinderbox;69;69;70;69;73;69;70;69;70;70 22:48:50 INFO - PROCESS | 27110 | |10;stanford-crypto-aes;89;87;84;87;85;87;86;87;92;84 22:48:50 INFO - PROCESS | 27110 | |11;stanford-crypto-ccm;128;124;128;128;123;128;124;135;136;132 22:48:50 INFO - PROCESS | 27110 | |12;stanford-crypto-pbkdf2;139;148;136;142;138;148;148;146;147;145 22:48:50 INFO - PROCESS | 27110 | |13;stanford-crypto-sha256-iterative;74;71;70;71;71;74;71;72;73;71 22:48:50 INFO - PROCESS | 27110 | __end_tp_report 22:48:50 INFO - PROCESS | 27110 | __start_cc_report 22:48:50 INFO - PROCESS | 27110 | _x_x_mozilla_cycle_collect,829 22:48:50 INFO - PROCESS | 27110 | __end_cc_report 22:48:50 INFO - PROCESS | 27110 | __startTimestamp1451458130707__endTimestamp 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | ------- Summary: start ------- 22:48:50 INFO - PROCESS | 27110 | Number of tests: 14 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:4.08 (3.6%) stddev-sans-first:4.30 22:48:50 INFO - PROCESS | 27110 | Values: 113.0 109.0 113.0 114.0 113.0 125.0 114.0 114.0 113.0 114.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:155.50 stddev:15.24 (9.8%) stddev-sans-first:16.05 22:48:50 INFO - PROCESS | 27110 | Values: 156.0 131.0 154.0 165.0 133.0 155.0 168.0 137.0 172.0 137.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:3.05 22:48:50 INFO - PROCESS | 27110 | Values: 164.0 164.0 164.0 162.0 162.0 166.0 172.0 164.0 164.0 163.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#3] audio-fft Cycles:10 Average:81.20 Median:73.50 stddev:20.43 (27.8%) stddev-sans-first:21.40 22:48:50 INFO - PROCESS | 27110 | Values: 72.0 75.0 72.0 74.0 137.0 72.0 74.0 73.0 72.0 91.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.50 stddev:18.78 (19.5%) stddev-sans-first:19.22 22:48:50 INFO - PROCESS | 27110 | Values: 96.0 100.0 136.0 97.0 102.0 98.0 141.0 98.0 98.0 134.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.00 stddev:1.65 (1.5%) stddev-sans-first:1.66 22:48:50 INFO - PROCESS | 27110 | Values: 109.0 110.0 109.0 110.0 114.0 113.0 110.0 110.0 110.0 110.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 22:48:50 INFO - PROCESS | 27110 | Values: 148.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 148.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 22:48:50 INFO - PROCESS | 27110 | Values: 96.0 96.0 98.0 96.0 97.0 97.0 98.0 97.0 96.0 96.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.00 stddev:1.60 (2.2%) stddev-sans-first:1.69 22:48:50 INFO - PROCESS | 27110 | Values: 71.0 71.0 70.0 71.0 72.0 71.0 69.0 70.0 71.0 75.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 22:48:50 INFO - PROCESS | 27110 | Values: 69.0 69.0 70.0 69.0 73.0 69.0 70.0 69.0 70.0 70.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:2.39 (2.8%) stddev-sans-first:2.40 22:48:50 INFO - PROCESS | 27110 | Values: 89.0 87.0 84.0 87.0 85.0 87.0 86.0 87.0 92.0 84.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.00 stddev:4.50 (3.5%) stddev-sans-first:4.77 22:48:50 INFO - PROCESS | 27110 | Values: 128.0 124.0 128.0 128.0 123.0 128.0 124.0 135.0 136.0 132.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:146.50 stddev:4.60 (3.1%) stddev-sans-first:4.55 22:48:50 INFO - PROCESS | 27110 | Values: 139.0 148.0 136.0 142.0 138.0 148.0 148.0 146.0 147.0 145.0 22:48:50 INFO - PROCESS | 27110 | 22:48:50 INFO - PROCESS | 27110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.50 stddev:1.40 (2.0%) stddev-sans-first:1.24 22:48:50 INFO - PROCESS | 27110 | Values: 74.0 71.0 70.0 71.0 71.0 74.0 71.0 72.0 73.0 71.0 22:48:50 INFO - PROCESS | 27110 | -------- Summary: end -------- 22:48:50 INFO - PROCESS | 27110 | 22:48:51 INFO - TEST-INFO | 27110: exit 0 22:48:51 INFO - TEST-OK | kraken | took 61595ms 22:48:51 INFO - TEST-START | v8_7 22:48:51 INFO - operating with platform_type : linux_ 22:48:51 INFO - Initialising browser for v8_7 test... 22:48:51 INFO - TEST-INFO | started process 27395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vveR3/profile http://localhost:53607/getInfo.html) 22:48:56 INFO - PROCESS | 27395 | __metrics Screen width/height:1600/1200 22:48:56 INFO - PROCESS | 27395 | colorDepth:24 22:48:56 INFO - PROCESS | 27395 | Browser inner width/height: 1024/697 22:48:56 INFO - PROCESS | 27395 | __metrics 22:48:56 INFO - PROCESS | 27395 | 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:57 INFO - TEST-INFO | 27395: exit 0 22:48:57 INFO - Browser initialized. 22:48:57 INFO - Running cycle 1/1 for v8_7 test... 22:48:57 INFO - TEST-INFO | started process 27516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vveR3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:49:09 INFO - PROCESS | 27516 | RSS: Main: 149282816 22:49:09 INFO - PROCESS | 27516 | 22:49:30 INFO - PROCESS | 27516 | Cycle 1(1): loaded http://localhost:53607/tests/v8_7/run.html (next: http://localhost:53607/tests/v8_7/run.html) 22:49:31 INFO - PROCESS | 27516 | RSS: Main: 145371136 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | __start_tp_report 22:49:31 INFO - PROCESS | 27516 | _x_x_mozilla_page_load 22:49:31 INFO - PROCESS | 27516 | _x_x_mozilla_page_load_details 22:49:31 INFO - PROCESS | 27516 | |i|pagename|runs| 22:49:31 INFO - PROCESS | 27516 | |0;Richards;167.61649346295675 22:49:31 INFO - PROCESS | 27516 | |1;DeltaBlue;187.16077110237694 22:49:31 INFO - PROCESS | 27516 | |2;Encrypt;277.85495971103086 22:49:31 INFO - PROCESS | 27516 | |3;Decrypt;5186.5284974093265 22:49:31 INFO - PROCESS | 27516 | |4;RayTrace;1097.694840834248 22:49:31 INFO - PROCESS | 27516 | |5;Earley;726.2164124909223 22:49:31 INFO - PROCESS | 27516 | |6;Boyer;12500 22:49:31 INFO - PROCESS | 27516 | |7;RegExp;25717.94871794872 22:49:31 INFO - PROCESS | 27516 | |8;Splay;601.3229104028864 22:49:31 INFO - PROCESS | 27516 | |9;NavierStokes;4830.917874396136 22:49:31 INFO - PROCESS | 27516 | __end_tp_report 22:49:31 INFO - PROCESS | 27516 | __startTimestamp1451458171149__endTimestamp 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | ------- Summary: start ------- 22:49:31 INFO - PROCESS | 27516 | Number of tests: 10 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 167.6 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#1] DeltaBlue Cycles:1 Average:187.16 Median:187.16 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 187.2 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 277.9 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 5186.5 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#4] RayTrace Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 1097.7 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#5] Earley Cycles:1 Average:726.22 Median:726.22 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 726.2 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 12500.0 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 25717.9 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#8] Splay Cycles:1 Average:601.32 Median:601.32 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 601.3 22:49:31 INFO - PROCESS | 27516 | 22:49:31 INFO - PROCESS | 27516 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:49:31 INFO - PROCESS | 27516 | Values: 4830.9 22:49:31 INFO - PROCESS | 27516 | -------- Summary: end -------- 22:49:31 INFO - PROCESS | 27516 | 22:49:32 INFO - TEST-INFO | 27516: exit 0 22:49:32 INFO - TEST-OK | v8_7 | took 40332ms 22:49:32 INFO - SUITE-END | took 1216s 22:49:32 INFO - Completed test suite (00:20:16) 22:49:32 INFO - Working with test: dromaeo_css 22:49:32 INFO - Generating results file: dromaeo_css 22:49:32 INFO - Working with test: kraken 22:49:32 INFO - Generating results file: kraken 22:49:32 INFO - javascript benchmark 22:49:32 INFO - Working with test: v8_7 22:49:32 INFO - Generating results file: v8_7 22:49:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 22:49:32 INFO - process_Request line: dromaeo_css 6142.08 graph.html#tests=[[72,132,43]] 22:49:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:32 INFO - process_Request line: kraken 1547.50 graph.html#tests=[[232,132,43]] 22:49:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:32 INFO - process_Request line: v8_7 21221.85 graph.html#tests=[[230,132,43]] 22:49:32 INFO - RETURN: dromaeo_css: 6142.08 22:49:32 INFO - RETURN: kraken: 1547.50 22:49:32 INFO - RETURN: v8_7: 21221.85 22:49:32 INFO - javascript benchmark 22:49:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2635.3279913622027, 2714.1857442767164, 2741.205050535345, 2753.545664965281, 2766.7509924106826, 4610.538946105387, 4678.438587369516, 4716.151092803294, 4726.7400292983875, 4752.691075080117, 4635.953640463595, 4648.837290694826, 4668.929966050512, 4794.3767310249705, 4804.471508134111, 4318.460192475933, 4392.428984232045, 4456.777161141946, 4464.955350446487, 4494.056248187884, 4418.204723149832, 4426.579474949875, 4429.800658970354, 4438.933415998763, 4523.502414734393, 4257.808398622069, 4333.393324934512, 4406.162829062468, 4416.447944006999, 4477.820887164526, 4348.412964249817, 4434.977825110886, 4447.5552444755585, 4463.4420697412825, 4466.977665111686, 4316.2446571849805, 4361.5856493633055, 4363.890902727458, 4376.452943382077, 4396.56034396561, 4420.20436321462, 4561.954380456186, 4564.497905230422, 4577.908441831145, 4656.32483289921, 5121.795128194868, 5133.435322114565, 5145.614078944057, 5147.459516750725, 5154.098032844237, 5150.948490515084, 5187.377514698261, 5188.688678679291, 5193.143131383317, 5230.843074707765, 4561.475430325489, 4666.8133274668635, 4674.415698037746, 4680.438347398334, 4779.474257831635, 5265.789368425297, 5275.868103297448, 5276.419593844674, 5282.498162674539, 5288.8413347599635, 5046.318746969112, 5071.163258062452, 5077.619178561548, 5079.060373830853, 5110.310108135429, 4889.804407823647, 5034.043531728959, 5062.493750624908, 5141.920196758722, 5167.22491626259, 4945.381827271591, 4965.0, 4973.875653108629, 5048.394192696826, 5071.239314102841, 4981.551660350586, 4996.5003499650475, 5003.649744517922, 5007.148784706608, 5063.088644044034, 4147.730397524151, 4240.215560121325, 4240.660747140221, 4297.634701050446, 4340.804663790137, 3715.869944551928, 3717.312297224968, 3719.1074142205675, 3737.9626203738158, 3739.7943113128495, 4254.255505286563, 4392.2752745797225, 4393.077453734688, 4405.911881762411, 4420.359047938031, 4993.700377977333, 5073.036123136592, 5144.176931690987, 5152.330197074356, 5188.169892817131, 4360.760158191267, 4370.453693288339, 4418.55814418562, 4425.867223983286, 4454.933176002362, 4342.32693932441, 4449.13241917823, 4528.298113792367, 4531.320301954733, 4558.635309175258, 4703.45910220329, 4812.783424745825, 4830.154722923404, 4842.055799119279, 4877.292792545061, 5103.77033033507, 5137.101007323628, 5143.202803565453, 5146.228065790161, 5151.433342332265, 4713.222318317439, 4824.662273640952, 4825.3485779419325, 4867.099586576494, 4933.914538801458, 4917.237828136645, 4997.025580011863, 5007.123753343078, 5017.473165317735, 5047.29337892688, 5097.8725531862, 5112.642115051911, 5113.0, 5121.436641969306, 5164.122099243213, 4746.501617330131, 4847.927281090716, 4894.902101958012, 4955.975220123876, 4956.702597843997, 4960.77676504551, 4962.255661650637, 4978.377702787152, 4979.153543897619, 4985.651004429655, 4844.249141383091, 4849.0, 4871.878203044952, 4902.044101400335, 4938.925916111333, 4804.0872234275375, 4910.508949105204, 4915.65590408668, 5026.773795179152, 5083.2883396323805, 4944.92582611254, 4950.430700469492, 4955.207166853286, 4973.676711013773, 4981.501849814989], "unit": "score", "name": "dojo.html", "value": 4667.831342349703}, {"lowerIsBetter": false, "replicates": [504.5030644814858, 504.64422582079635, 506.98732531686704, 521.5175962234933, 571.901948259342, 32071.518927216082, 32488.40092792577, 32539.83730081352, 32713.67286327136, 32769.50845737316, 35101.64898351016, 35403.822980885125, 35771.2845743085, 35838.2832343353, 35922.640773592255, 7525.849483010336, 7632.771016869503, 7659.6936122555035, 7678.117016543085, 7688.846223075535, 7478.990336304583, 7522.736704215354, 7582.582957937311, 7603.2776886195725, 7625.923740762577, 7606.04924384452, 7694.076710794712, 7698.076230852277, 7699.576523291216, 7699.653515591812, 7525.397968162534, 7571.886421703679, 7576.772696819076, 7668.923310766877, 7688.500247483951, 7588.924110758932, 7663.233676632348, 7713.6914523419, 7716.305532502046, 7774.689012439496, 35474.0, 35521.82239088788, 35710.64289357099, 35777.46333804995, 35911.28177436463, 2706.91879243623, 2728.9727102729116, 2933.1054028521294, 3326.96673033269, 3396.456566949301, 27272.31819204516, 27402.314942126406, 27555.448891022268, 27908.720912790814, 28047.719522804713, 3247.951280730791, 3283.5238890360765, 3297.3570153820015, 3345.531625572422, 3363.764536482447, 223163.0, 224348.0, 225560.99999999837, 226189.0, 226464.0, 45874.5412545877, 46482.8868824429, 53414.465855341725, 54723.72638136784, 54933.72533137309, 47502.76248618735, 47519.287210691866, 47657.28514072292, 48066.5193348062, 48095.0, 11949.462274197682, 12177.147599667938, 12247.265164090182, 12248.142630015991, 12262.877371226174, 8060.919390806134, 8087.272145506932, 8119.675212991414, 8128.837423251502, 8166.305864001626, 18266.634667306844, 18624.348147814762, 18645.81354186441, 18761.15574799137, 18819.682622216587, 7519.924800751923, 7720.073591169095, 7854.6858125674335, 7858.0, 7883.0, 907.3059109781022, 934.6354921580589, 964.0744884910424, 1036.7252678040325, 1051.453244312953, 25371.238862834143, 25401.237962861145, 25947.610785838227, 25994.87002564975, 26207.820648070883, 921.7972046149837, 977.1498796047342, 979.5004547680592, 987.5259875259771, 1059.9311044782219, 12281.324527150913, 12423.44094515749, 12516.74966500665, 12578.622641320775, 12615.404609686195, 303257.0, 313859.0, 315803.0, 316340.0, 318764.0, 45668.08663826705, 46158.0, 46302.305465418045, 46365.768171158925, 46527.0, 1172.536847945057, 1178.4579093617033, 1186.768580126867, 1188.8454500914825, 1199.7300607363272, 23398.883005584863, 29635.407291854473, 30396.240093997825, 30566.1413979968, 31127.533087004165, 41888.3716744243, 42289.0, 42610.0, 42665.786671066446, 42781.78609106935, 244833.0, 247230.0, 247738.0, 248849.0, 249358.0, 37172.25655486821, 37779.0, 37848.81075594604, 37989.24021519499, 38368.0, 34025.65974340225, 38007.619923800405, 38151.42772858354, 38209.04477388087, 38582.80708596551, 30913.69086309108, 31537.684623153476, 31989.0, 32187.195320117185, 32434.21611811373, 32888.177795554344, 32971.67028329686, 34211.605187636625, 36056.63943360533, 36234.637653623126, 30337.24156896095, 33959.83020084884, 34936.475952861234, 35124.0, 35176.47235291524, 25832.483350333263, 27686.0, 27728.168154955383, 27972.860135699193, 28201.0, 21742.891285543472, 23515.294541163792, 23574.88212558926, 23575.0, 23761.762382375953], "unit": "score", "name": "ext.html", "value": 16493.23022281421}, {"lowerIsBetter": false, "replicates": [334.785737128238, 334.97990120592766, 336.90566641340433, 338.0787354459098, 338.5024014698393, 14453.060551064187, 14803.555893323191, 15441.613959651015, 15633.843661563382, 16063.518094457186, 14733.557993260192, 14790.85209147911, 15043.548693539184, 15092.868034897372, 15105.77341339878, 4217.346311321742, 4562.224421848277, 4573.542645735433, 4577.107464044512, 4581.633469322446, 4977.950220497803, 5004.699718016931, 5024.899502009957, 5038.722870242135, 5039.344885164942, 4780.0, 4871.318015477836, 4928.334674818907, 4943.950560494403, 4982.651214414992, 4849.539293767104, 4917.901641967176, 4919.843836698373, 4940.209566469365, 5218.947810521884, 5041.546260836542, 5044.621653375974, 5080.263361812554, 5091.745412729349, 5093.592512598983, 10852.891471085268, 10896.618618348399, 14026.789598156036, 18782.436526904214, 18818.623627527373, 1612.5001249612658, 1659.7551736512562, 1667.25807015878, 1709.4102534625658, 1717.690815653182, 8524.78688032798, 8689.17452841979, 8853.867191992125, 8998.55007249635, 9380.765480862965, 1634.1584084196647, 1648.8021437427585, 1718.1789289686874, 1720.4494561740248, 1790.444962061752, 54324.45675543234, 55936.72031639856, 56081.43918560844, 57312.426875731544, 58155.41844581585, 9470.242380609672, 9646.855297170549, 9924.354916930377, 9945.552450139761, 9955.303128780915, 12608.558700445441, 12610.0, 12613.936930315473, 12616.36918154107, 12658.62024139259, 6104.114903338991, 6279.654618995999, 6456.451201647818, 6494.1232933553365, 6508.576942498722, 5975.910361344583, 6062.878742425127, 6089.269287685506, 6105.267367915879, 6132.754689812357, 3889.199217970698, 3918.647321741, 4111.60939710727, 4199.496060472702, 4270.274053410928, 1694.1867903406187, 1761.3923196497187, 1780.6883795336023, 1792.8386445219992, 1818.8453981411728, 357.4887910288261, 359.69605683197653, 363.0560542589247, 364.2569158915835, 387.656923622596, 9170.770730731785, 9336.719898403058, 9526.571304291185, 9540.141387275178, 9649.469279189712, 371.35199077609747, 379.90122568132483, 381.3326678312952, 385.41801879162665, 393.0998014546713, 5298.0, 5321.201819727072, 5352.330958630171, 5407.864803379947, 5431.6740995540395, 310376.0, 315739.0, 318228.0, 536448.0, 536704.0, 35259.82370088133, 48947.02105957861, 58420.7078964611, 59986.40013599808, 60260.397396026354, 972.4262685015733, 1008.7276435362411, 1011.3881101933372, 1014.7158795537409, 1016.1261315269011, 14585.416583336548, 14587.0, 14587.520121579144, 14798.96407251482, 15120.924395377953, 30996.845015775678, 31292.061238162893, 31843.20391990219, 32289.192770180933, 32403.837980809945, 40938.385924211754, 41388.79305603453, 41914.58085419107, 43028.56971430371, 44056.77971610121, 8342.582870856555, 8454.577271136295, 8502.914970850212, 8509.489430634181, 8567.91432085696, 9723.513824308615, 9861.359011664219, 15050.774238386213, 15899.205039748198, 15964.20178991069, 11851.0, 12777.616671499869, 13225.537106201236, 13322.33388330599, 13662.11196272239, 12937.223766574036, 13098.672533186365, 13318.733625327633, 13399.397027133607, 13410.32948352559, 13538.390772415069, 13954.58136255914, 14325.57023289303, 14431.278436077944, 14496.0, 8507.82984340322, 8670.089640587648, 8686.52224127679, 8834.249088827522, 8857.247133993682, 13503.054786164874, 13616.65958351049, 13637.0, 13954.162750235018, 14144.43422263098], "unit": "score", "name": "jquery.html", "value": 7350.015899889204}, {"lowerIsBetter": false, "replicates": [1305.706216101377, 1367.200187890084, 1449.9710005799884, 1684.5788552861784, 1688.1306127344412, 5920.0, 5978.491828194608, 7042.683079261433, 7161.104861892263, 7163.964180179092, 6724.899126513106, 6888.276730943254, 6891.689873955672, 6940.6876690548925, 6968.442524598033, 2081.0427203486374, 2110.05047728522, 2123.936281911537, 2125.064971412581, 2125.5642593268344, 2125.3305208859238, 2127.2448280860303, 2151.4191168384527, 2154.278316763886, 2160.82713382929, 2082.063071617778, 2087.65553683642, 2090.383336915606, 2116.502621883856, 2117.978820211801, 2090.216168936649, 2100.779418161094, 2108.7891210878943, 2110.9788902110936, 2120.8409369297365, 2076.3148161106797, 2119.279444988696, 2119.79861913118, 2125.6705210692367, 2144.721186245794, 7044.15470143586, 7054.294570542956, 7063.081799366049, 7161.069061022086, 7168.60572668503, 4036.535798383165, 4122.505299364066, 4132.793360331972, 4145.067359844041, 4156.9792151039055, 2821.8730157142977, 2831.3346363604537, 2946.6169397978124, 2951.9557206641916, 2954.4829654810324, 890.0876601483467, 913.7943962608426, 928.6749637626845, 939.6335429182556, 942.1285311087286, 9323.953380233123, 9386.389884657543, 9421.764455888657, 9477.905220947703, 9482.288828337902, 3880.3597406427625, 3890.0, 3904.882853514399, 3964.226975739703, 3966.1076257841755, 8191.8771218431775, 8203.220694034057, 8234.588270586446, 8258.876116858251, 8268.545230012407, 4250.851220207278, 4276.102018576072, 4299.312110062375, 4309.892252693645, 4321.2653848845775, 3735.234276973214, 3850.8074596270076, 3862.4978752761963, 3896.5518965318784, 3916.6279203475624, 3264.1676372524853, 3267.379197952381, 3268.3953468608383, 3290.0, 3303.421901167334, 977.413551868873, 982.4645568165367, 986.1272773595276, 1009.1422291052546, 1011.7723512209841, 874.606427107804, 874.6588830356167, 883.6200433813522, 1096.2326371539793, 1102.735343517566, 6675.165604299463, 6692.397684208445, 6765.797026089225, 6783.966080169666, 6792.0830687856505, 407.0515698422668, 407.69015548183, 410.4848415238856, 412.23530351198696, 412.5523806669737, 5149.0, 5198.532132108128, 5258.342707161605, 5264.815731449381, 5265.078611243017, 8324.959380077491, 8478.23695867375, 8575.185357391163, 8575.3997220194, 8627.309815214894, 8221.136780638066, 8330.458520196167, 8333.916660833434, 8347.833043339098, 8470.322374210049, 6688.331166883273, 6694.096296999843, 6705.932940670628, 6718.731250750013, 6729.360710732472, 6163.506919446523, 6219.191505104489, 6314.652694101868, 6322.589031712924, 6338.461230795434, 7469.925300746923, 7519.924800751923, 7565.470417070752, 7662.540247585162, 7667.463277570517, 7274.127104747464, 7354.264573542603, 7374.6681399336085, 7408.888866667112, 7490.325870671666, 5404.243405923095, 5460.836174914759, 6100.389961004042, 6114.6942652868065, 6236.688165591611, 6448.484121270381, 6488.156539649815, 6537.5750576212395, 6545.672716364067, 6558.901616475852, 5882.647041177543, 5967.6419414835245, 6008.699565021819, 6009.128676341993, 6079.908801368071, 5828.679422631796, 5874.236349274567, 5899.941000589939, 5965.9105113422465, 5981.312149102909, 5959.344472108151, 5987.64074155552, 6069.817905462844, 6203.379662033761, 6232.563720539519, 5762.711864406847, 5803.187553742395, 5804.187413762161, 5817.243758311392, 5822.359540450631, 5914.556408269311, 5935.465808077293, 5944.613600115978, 6003.849903752266, 6012.3085845126625], "unit": "score", "name": "mootools.html", "value": 3929.4920111356196}, {"lowerIsBetter": false, "replicates": [293.8427941051537, 302.9970796663045, 310.3002728846454, 310.5000948472958, 313.7772181750957, 5512.228288039678, 5513.58648101392, 5523.061079616465, 5568.66588004719, 5674.460926212014, 5513.3108361454815, 5546.86132846679, 5558.833235002957, 5570.944290557103, 5582.218489411485, 4229.873103806891, 4252.702310838243, 4262.850800221993, 4269.210196113713, 4275.42281791958, 4253.191893540217, 4261.275583150872, 4277.165952639237, 4286.678499112563, 4292.957070429303, 4116.0, 4164.042270277838, 4168.145530166324, 4251.59609837065, 4258.659307255412, 4223.36649502574, 4224.471941007374, 4232.724872883253, 4238.851640192578, 4250.319948808191, 3676.5036720042717, 3686.3364594373, 3689.6679298863232, 3691.8370713225518, 3704.1665625234377, 5263.815766448194, 5269.156934890438, 5270.1040823060175, 5274.683518988834, 5276.868078298035, 4666.556677115668, 4789.233722604366, 4884.560389564921, 4901.950980490221, 4909.337239472697, 5854.97072514639, 5859.824205273806, 5862.443067908584, 5867.559933005042, 5871.970640146815, 4010.7994600270163, 4023.6177563131455, 4028.8992775180564, 4033.253848038122, 4041.8585349512628, 6073.635581865102, 6146.016637338049, 6156.999999999955, 6164.321924588292, 6167.5682702210415, 4009.1981603679383, 4110.260153172458, 4115.670746340285, 4140.896477588024, 4142.316517774594, 4142.378643203483, 4160.334346504545, 4199.265128602544, 4202.054537728986, 4211.410402543646, 4812.5668689817385, 4871.585915197248, 4871.683340582851, 4879.682820616648, 4892.902141957141, 5815.185873977646, 5857.150713146655, 5861.677607731615, 5871.031279838864, 5871.32479764824, 1466.4354223623768, 1494.880409567232, 1501.3919362658141, 1507.6457032597332, 1538.7076455473425, 1037.4397825174321, 1050.7110544600296, 1053.2153545608417, 1059.9841002384971, 1069.6256310291335, 5071.137906555894, 5107.7446127693465, 5116.488351164854, 5124.359455068116, 5137.666051706702, 6032.39676032402, 6044.274687037584, 6059.787907423219, 6070.7875224366935, 6075.544334174954, 5090.0583392072585, 5110.182370820651, 5124.92312615311, 5126.38483381989, 5137.717425541631, 3192.0902542775198, 3216.887408940676, 3258.8207648579555, 3271.116798464401, 3278.868845246211, 5718.142278658152, 5719.828405147852, 5723.284589426322, 5726.169705392695, 5727.6849773262875, 6143.1706719592285, 6178.69106544671, 6200.3179650238435, 6212.81361559154, 6213.782517611862, 5578.382269141985, 5619.606627536034, 5716.828495145152, 5719.084946408555, 5720.942790572124, 6151.5386346025125, 6159.538034647329, 6166.969165154145, 6168.0, 6169.413905678954, 5968.343482217039, 5981.940180598138, 5987.31145918225, 5993.910091348721, 5994.430529099728, 5605.691686957257, 5774.105013722879, 5798.043322851682, 5807.157962095557, 5816.41835816415, 4308.4399028126145, 4308.784560772012, 4314.460692413449, 4314.870553883388, 4320.848770293024, 6141.263048434216, 6152.446279834837, 6155.2921414037955, 6157.753689852535, 6159.4456498915315, 5872.354041055566, 5912.083627037816, 5914.2311499504785, 5921.61509501881, 5925.733341999707, 5749.310082790092, 5823.0, 5885.440883116097, 5900.557458190567, 5921.259842519685, 5703.543716502587, 5728.627639203439, 5737.282839645044, 5762.1068734346245, 5764.711764411846, 5900.822975310576, 5910.0, 5921.674307912934, 5922.378150294329, 5939.792107276225, 5655.1517272409465, 5777.508911742549, 5793.623414478214, 5799.4780469757925, 5799.884002320015], "unit": "score", "name": "prototype.html", "value": 4383.532061134589}, {"lowerIsBetter": false, "replicates": [703.9859202815943, 711.4237467651203, 720.2221600671276, 740.6815069520104, 746.1605693594706, 10811.189160812932, 10833.349999000066, 11001.284916480423, 11008.559657613696, 11043.619547556555, 10918.727031824208, 10997.395143267117, 11114.888851111486, 11127.499262533185, 11179.720506987309, 747.6224506624147, 757.5719718359137, 767.4282659418741, 768.0974854545914, 774.7133560582593, 761.5659074327608, 766.7316439246247, 767.6775754183257, 770.6801677303912, 772.2162005564329, 798.7723498802842, 805.5005896344245, 808.8786681997718, 811.4847072109194, 812.5733989655448, 795.3915254830031, 798.7244400681756, 801.3068695578341, 802.4663598706853, 802.8675268580677, 589.8171566814301, 592.973316200772, 593.1103344982527, 594.2631137389649, 595.0865421577901, 10121.645742398981, 10190.59237630494, 10221.0, 10238.795224095476, 10242.9487852561, 9995.25035622324, 10761.946190268998, 10848.294860834021, 11224.214304998653, 11300.434978251054, 9116.544172791333, 9131.589078491485, 9364.110409511153, 9473.905260947371, 9518.238540916711, 3166.936661266785, 3224.467962786161, 3238.465653167248, 3279.0490757680245, 3286.819224942627, 39946.201075978606, 40330.79834600838, 40369.19261614751, 40449.79775101106, 40488.79755601232, 8646.481211127353, 8853.424527405698, 8881.467111973174, 9022.278217742565, 9033.593488293043, 15819.52541423759, 15825.446109386115, 15827.52517424479, 15841.603959900864, 15870.44453444124, 5976.133460648269, 6006.909896351558, 6042.516598672096, 6050.183225264533, 6108.1143234230785, 3352.966470335314, 3395.0833275015607, 3424.760266781351, 3443.9483407748903, 3449.6722811333384, 2980.195347256272, 3039.149038269288, 3059.7705172111737, 3066.018873960356, 3076.984615076955, 499.2910067703797, 511.6827566908466, 516.7442116152529, 518.7095226673075, 520.3911423634357, 387.54657051250103, 404.5711545761502, 406.7295248659667, 417.67838764151435, 426.6608046602958, 6245.500359971192, 6719.294474080249, 6828.283030281848, 6900.102986611709, 6987.650617469106, 418.374530077536, 459.3064472646328, 488.9731064791471, 540.3839622829977, 551.2145193099817, 3140.890068847579, 3149.33863888586, 3163.430582495173, 3178.6503484616674, 3243.156779237368, 48524.27213591799, 48666.513334866904, 48705.5129448708, 48820.75589622029, 51630.48369516257, 42449.0, 42452.0, 43033.13933721371, 43081.35377969333, 43288.13423731508, 42567.787161064, 44679.0, 44875.775621121684, 45272.54727452749, 45879.77060114678, 7019.789406317818, 7172.450661558197, 7176.318249766264, 7288.453365997678, 7360.668769905475, 31429.214269643442, 31656.683433166294, 31965.24191169508, 32185.67814321827, 33160.0, 38076.23847522979, 38470.42294365531, 39553.604463956144, 40015.599844002354, 40228.0, 10170.0, 10474.266801324138, 10529.315594486334, 11291.774164516499, 11309.0, 10959.945200273947, 11074.778504430027, 11350.148738844455, 11420.086393088699, 11715.941420292844, 9773.218142548722, 9807.460589667637, 10250.333728307636, 10548.630797922036, 10662.360258384522, 9613.327067105236, 10300.742481438025, 10329.12202462799, 10607.840882386616, 10841.078508326565, 9161.0, 9450.054994500495, 9543.665971690958, 9699.9030009699, 9712.417254964725, 9504.667336643184, 9546.0, 9626.518674066128, 9747.805043898941, 10105.343152695052, 8817.509210907321, 8834.116588341114, 8875.156860098281, 9114.40756350835, 9131.886727466055], "unit": "score", "name": "yui.html", "value": 5507.815587419931}], "name": "dromaeo_css", "value": 6142.077585015303}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 113.0, 114.0, 113.0, 125.0, 114.0, 114.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 154.0, 165.0, 133.0, 155.0, 168.0, 137.0, 172.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 162.0, 162.0, 166.0, 172.0, 164.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 72.0, 74.0, 137.0, 72.0, 74.0, 73.0, 72.0, 91.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [96.0, 100.0, 136.0, 97.0, 102.0, 98.0, 141.0, 98.0, 98.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 114.0, 113.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 97.0, 97.0, 98.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 71.0, 72.0, 71.0, 69.0, 70.0, 71.0, 75.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 73.0, 69.0, 70.0, 69.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 84.0, 87.0, 85.0, 87.0, 86.0, 87.0, 92.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 128.0, 128.0, 123.0, 128.0, 124.0, 135.0, 136.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.6}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 136.0, 142.0, 138.0, 148.0, 148.0, 146.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 70.0, 71.0, 71.0, 74.0, 71.0, 72.0, 73.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1547.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [187.16077110237694], "unit": "score", "name": "DeltaBlue", "value": 353.2684740000001}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1097.694840834248], "unit": "score", "name": "RayTrace", "value": 674.1299790000003}, {"lowerIsBetter": false, "replicates": [726.2164124909223], "unit": "score", "name": "Earley", "value": 917.719551}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [25717.94871794872], "unit": "score", "name": "RegExp", "value": 35.42214855433696}, {"lowerIsBetter": false, "replicates": [601.3229104028864], "unit": "score", "name": "Splay", "value": 135.519533}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21221.84534776917}]} 22:49:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21221.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1547.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6142.08"}}} 22:49:32 INFO - Return code: 0 22:49:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:49:32 INFO - # TBPL SUCCESS # 22:49:32 INFO - Running post-action listener: _resource_record_post_action 22:49:32 INFO - Running post-run listener: _resource_record_post_run 22:49:33 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559063040; Read time: 12; Write time: 514068 22:49:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243281920; Read time: 0; Write time: 318540 22:49:33 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315781120; Read time: 12; Write time: 195528 22:49:33 INFO - Running post-run listener: _upload_blobber_files 22:49:33 INFO - Blob upload gear active. 22:49:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:49:33 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:33 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:33 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:33 INFO - (blobuploader) - INFO - Open directory for files ... 22:49:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:49:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:34 INFO - (blobuploader) - INFO - Done attempting. 22:49:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:49:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:49:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:35 INFO - (blobuploader) - INFO - Done attempting. 22:49:35 INFO - (blobuploader) - INFO - Iteration through files over. 22:49:35 INFO - Return code: 0 22:49:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:49:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:49:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4785b203662cc724e8c1a5af0a97c51e75f2051e510c6b1e50e421aac09080ac10a4b3dd064bf5bb39b25b090b2e96bf2cc15ab15dfd653bee081714aefc7fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0ebf120bf533a59e981a1aa92373e82c6c6411b0d2833965b2d502339be4f81fcde9c1dd5b9011c93b57faf746d02cb5e0244aee0476b4c86cfcbd4978838ed"} 22:49:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:49:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:49:35 INFO - Contents: 22:49:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4785b203662cc724e8c1a5af0a97c51e75f2051e510c6b1e50e421aac09080ac10a4b3dd064bf5bb39b25b090b2e96bf2cc15ab15dfd653bee081714aefc7fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0ebf120bf533a59e981a1aa92373e82c6c6411b0d2833965b2d502339be4f81fcde9c1dd5b9011c93b57faf746d02cb5e0244aee0476b4c86cfcbd4978838ed"} 22:49:35 INFO - Copying logs to upload dir... 22:49:35 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.378474 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-29 22:49:34.940391) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:34.944829) ========= 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=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4785b203662cc724e8c1a5af0a97c51e75f2051e510c6b1e50e421aac09080ac10a4b3dd064bf5bb39b25b090b2e96bf2cc15ab15dfd653bee081714aefc7fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0ebf120bf533a59e981a1aa92373e82c6c6411b0d2833965b2d502339be4f81fcde9c1dd5b9011c93b57faf746d02cb5e0244aee0476b4c86cfcbd4978838ed"} 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.011180 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4785b203662cc724e8c1a5af0a97c51e75f2051e510c6b1e50e421aac09080ac10a4b3dd064bf5bb39b25b090b2e96bf2cc15ab15dfd653bee081714aefc7fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d0ebf120bf533a59e981a1aa92373e82c6c6411b0d2833965b2d502339be4f81fcde9c1dd5b9011c93b57faf746d02cb5e0244aee0476b4c86cfcbd4978838ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:34.974522) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:34.974956) ========= 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=61fa6ed41387771909ec0f71000001b3-1451438242.873959-2070582932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:49:35.061035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:49:35.061444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:49:35.061806) ========= ========= Total master_lag: 0.27 =========