builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1469101273.33 results: success (0) buildid: 20160721032136 builduid: 4ef7822cfebb4c1993cbee858f2b0f99 revision: c050984325e379286c1456a261b0cdc92dab89c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.329100) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.329568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.329875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.344713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.344991) ========= 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=d2a8c569965ab8367867b893000001a1-1469101272.961243-360279003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 04:41:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-07-21 04:41:14 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.441576) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.441980) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=d2a8c569965ab8367867b893000001a1-1469101272.961243-360279003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021154 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.492302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:13.492656) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c050984325e379286c1456a261b0cdc92dab89c1 --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 c050984325e379286c1456a261b0cdc92dab89c1 --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=d2a8c569965ab8367867b893000001a1-1469101272.961243-360279003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 04:41:14,144 truncating revision to first 12 chars 2016-07-21 04:41:14,144 Setting DEBUG logging. 2016-07-21 04:41:14,144 attempt 1/10 2016-07-21 04:41:14,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c050984325e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 04:41:14,479 unpacking tar archive at: fx-team-c050984325e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:14.360016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:14.360357) ========= script_repo_revision: c050984325e379286c1456a261b0cdc92dab89c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:14.360775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:14.361045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:41:14.410155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-21 04:41:14.410576) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=d2a8c569965ab8367867b893000001a1-1469101272.961243-360279003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:41:15 INFO - MultiFileLogger online at 20160721 04:41:15 in /builds/slave/test 04:41:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:41:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:15 INFO - {'append_to_log': False, 04:41:15 INFO - 'base_work_dir': '/builds/slave/test', 04:41:15 INFO - 'blob_upload_branch': 'Fx-Team', 04:41:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:15 INFO - 'branch': 'Fx-Team', 04:41:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:15 INFO - 'config_files': ('talos/linux_config.py',), 04:41:15 INFO - 'default_actions': ('clobber', 04:41:15 INFO - 'read-buildbot-config', 04:41:15 INFO - 'download-and-extract', 04:41:15 INFO - 'populate-webroot', 04:41:15 INFO - 'create-virtualenv', 04:41:15 INFO - 'install', 04:41:15 INFO - 'run-tests'), 04:41:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:15 INFO - 'download_minidump_stackwalk': True, 04:41:15 INFO - 'download_symbols': 'ondemand', 04:41:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:15 INFO - 'installer_path': 'installer.exe', 04:41:15 INFO - 'log_level': 'info', 04:41:15 INFO - 'log_name': 'talos', 04:41:15 INFO - 'log_to_console': True, 04:41:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:41:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:41:15 INFO - 'opt_config_files': (), 04:41:15 INFO - 'pip_index': False, 04:41:15 INFO - 'sps_profile': False, 04:41:15 INFO - 'sps_profile_interval': 0, 04:41:15 INFO - 'suite': 'dromaeojs-e10s', 04:41:15 INFO - 'system_bits': '32', 04:41:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:15 INFO - 'title': 'talos-linux64-ix-043', 04:41:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:15 INFO - 'use_talos_json': True, 04:41:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:15 INFO - 'work_dir': 'build'} 04:41:15 INFO - [mozharness: 2016-07-21 11:41:15.152407Z] Running clobber step. 04:41:15 INFO - Running pre-action listener: _resource_record_pre_action 04:41:15 INFO - Running main action method: clobber 04:41:15 INFO - rmtree: /builds/slave/test/build 04:41:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:16 INFO - Running post-action listener: _resource_record_post_action 04:41:16 INFO - [mozharness: 2016-07-21 11:41:16.167256Z] Finished clobber step (success) 04:41:16 INFO - [mozharness: 2016-07-21 11:41:16.167356Z] Running read-buildbot-config step. 04:41:16 INFO - Running pre-action listener: _resource_record_pre_action 04:41:16 INFO - Running main action method: read_buildbot_config 04:41:16 INFO - Using buildbot properties: 04:41:16 INFO - { 04:41:16 INFO - "project": "", 04:41:16 INFO - "product": "firefox", 04:41:16 INFO - "script_repo_revision": "production", 04:41:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:41:16 INFO - "repository": "", 04:41:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:41:16 INFO - "buildid": "20160721032136", 04:41:16 INFO - "pgo_build": "True", 04:41:16 INFO - "basedir": "/builds/slave/test", 04:41:16 INFO - "buildnumber": 593, 04:41:16 INFO - "slavename": "talos-linux64-ix-043", 04:41:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:41:16 INFO - "platform": "ubuntu64_hw", 04:41:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:41:16 INFO - "branch": "fx-team", 04:41:16 INFO - "repo_path": "integration/fx-team", 04:41:16 INFO - "revision": "c050984325e379286c1456a261b0cdc92dab89c1", 04:41:16 INFO - "stage_platform": "linux64-pgo", 04:41:16 INFO - "builduid": "4ef7822cfebb4c1993cbee858f2b0f99", 04:41:16 INFO - "slavebuilddir": "test" 04:41:16 INFO - } 04:41:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:41:16 INFO - Running post-action listener: _resource_record_post_action 04:41:16 INFO - [mozharness: 2016-07-21 11:41:16.169796Z] Finished read-buildbot-config step (success) 04:41:16 INFO - [mozharness: 2016-07-21 11:41:16.169886Z] Running download-and-extract step. 04:41:16 INFO - Running pre-action listener: _resource_record_pre_action 04:41:16 INFO - Running main action method: download_and_extract 04:41:16 INFO - mkdir: /builds/slave/test/build/tests 04:41:16 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')]} 04:41:16 INFO - https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:41:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:41:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:41:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:41:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:41:16 INFO - Downloaded 1361 bytes. 04:41:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:41:16 INFO - Using the following test package requirements: 04:41:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:41:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:41:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'jsshell-linux-x86_64.zip'], 04:41:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:41:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:41:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:41:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:41:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:41:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:41:16 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')]} 04:41:16 INFO - https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:41:19 INFO - Downloaded 24343071 bytes. 04:41:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:41:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:41:21 INFO - Return code: 0 04:41:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:21 INFO - https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:41:22 INFO - Downloaded 24343071 bytes. 04:41:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:41:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:41:23 INFO - Return code: 0 04:41:23 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')]} 04:41:23 INFO - https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:41:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:41:25 INFO - Downloaded 14403317 bytes. 04:41:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:41:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:41:25 INFO - Return code: 0 04:41:25 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')]} 04:41:25 INFO - https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:41:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:41:28 INFO - Downloaded 60894499 bytes. 04:41:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:28 INFO - mkdir: /builds/slave/test/properties 04:41:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:41:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:41:28 INFO - Contents: 04:41:28 INFO - build_url:https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:28 INFO - Running post-action listener: _resource_record_post_action 04:41:28 INFO - Running post-action listener: set_extra_try_arguments 04:41:28 INFO - [mozharness: 2016-07-21 11:41:28.898740Z] Finished download-and-extract step (success) 04:41:28 INFO - [mozharness: 2016-07-21 11:41:28.898974Z] Running populate-webroot step. 04:41:28 INFO - Running pre-action listener: _resource_record_pre_action 04:41:28 INFO - Running main action method: populate_webroot 04:41:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:41:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:41:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:41:28 INFO - '--tppagecycles', 04:41:28 INFO - '7'], 04:41:28 INFO - 'tests': ['tsvgm']}}, 04:41:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:41:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:41:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:41:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:41:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['damp', 'tps']}, 04:41:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'tests': ['damp', 'tps']}, 04:41:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['dromaeo_dom']}, 04:41:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:41:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['basic_compositor_video']}, 04:41:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:41:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['a11yr', 04:41:28 INFO - 'ts_paint', 04:41:28 INFO - 'tpaint', 04:41:28 INFO - 'sessionrestore', 04:41:28 INFO - 'sessionrestore_no_auto_restore', 04:41:28 INFO - 'tabpaint']}, 04:41:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:41:28 INFO - 'ts_paint', 04:41:28 INFO - 'tpaint', 04:41:28 INFO - 'sessionrestore', 04:41:28 INFO - 'sessionrestore_no_auto_restore', 04:41:28 INFO - 'tabpaint']}, 04:41:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:41:28 INFO - 'ts_paint', 04:41:28 INFO - 'tpaint', 04:41:28 INFO - 'sessionrestore', 04:41:28 INFO - 'sessionrestore_no_auto_restore', 04:41:28 INFO - 'tabpaint']}, 04:41:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:41:28 INFO - 'ts_paint', 04:41:28 INFO - 'tpaint', 04:41:28 INFO - 'sessionrestore', 04:41:28 INFO - 'sessionrestore_no_auto_restore', 04:41:28 INFO - 'tabpaint']}, 04:41:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['a11yr', 04:41:28 INFO - 'ts_paint', 04:41:28 INFO - 'tpaint', 04:41:28 INFO - 'sessionrestore', 04:41:28 INFO - 'sessionrestore_no_auto_restore', 04:41:28 INFO - 'tabpaint']}, 04:41:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['a11yr', 04:41:28 INFO - 'ts_paint', 04:41:28 INFO - 'tpaint', 04:41:28 INFO - 'sessionrestore', 04:41:28 INFO - 'sessionrestore_no_auto_restore', 04:41:28 INFO - 'tabpaint']}, 04:41:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['tsvgx', 04:41:28 INFO - 'tsvgr_opacity', 04:41:28 INFO - 'tart', 04:41:28 INFO - 'tscrollx', 04:41:28 INFO - 'cart']}, 04:41:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:41:28 INFO - 'tsvgr_opacity', 04:41:28 INFO - 'tart', 04:41:28 INFO - 'tscrollx', 04:41:28 INFO - 'cart']}, 04:41:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'talos_options': ['--disable-e10s'], 04:41:28 INFO - 'tests': ['tp5o']}, 04:41:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'tests': ['tp5o']}, 04:41:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'talos_options': ['--disable-e10s', 04:41:28 INFO - '--xperf_path', 04:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:28 INFO - 'tests': ['tp5n']}, 04:41:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:28 INFO - 'talos_options': ['--xperf_path', 04:41:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:28 INFO - 'tests': ['tp5n']}}, 04:41:28 INFO - 'talos.zip': {'path': '', 04:41:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:41:28 INFO - Running post-action listener: _resource_record_post_action 04:41:28 INFO - [mozharness: 2016-07-21 11:41:28.919237Z] Finished populate-webroot step (success) 04:41:28 INFO - [mozharness: 2016-07-21 11:41:28.919326Z] Running create-virtualenv step. 04:41:28 INFO - Running pre-action listener: _resource_record_pre_action 04:41:28 INFO - Running main action method: create_virtualenv 04:41:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:41:28 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 04:41:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:41:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:41:29 INFO - Using real prefix '/usr' 04:41:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:41:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:41:31 INFO - Installing pip.................done. 04:41:31 INFO - Return code: 0 04:41:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:41:31 INFO - Using env: {'DISPLAY': ':0', 04:41:31 INFO - 'HOME': '/home/cltbld', 04:41:31 INFO - 'LANG': 'en_US.UTF-8', 04:41:31 INFO - 'LANGUAGE': 'en_US:en', 04:41:31 INFO - 'LOGNAME': 'cltbld', 04:41:31 INFO - 'MAIL': '/var/mail/cltbld', 04:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:31 INFO - 'MOZ_NO_REMOTE': '1', 04:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:31 INFO - 'NO_EM_RESTART': '1', 04:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:31 INFO - 'PWD': '/builds/slave/test', 04:41:31 INFO - 'SHELL': '/bin/bash', 04:41:31 INFO - 'SHLVL': '1', 04:41:31 INFO - 'TERM': 'linux', 04:41:31 INFO - 'TMOUT': '86400', 04:41:31 INFO - 'USER': 'cltbld', 04:41:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:31 INFO - '_': '/tools/buildbot/bin/python'} 04:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:31 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 04:41:31 INFO - Cleaning up... 04:41:31 INFO - Return code: 0 04:41:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 04:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 04:41:31 INFO - Using env: {'DISPLAY': ':0', 04:41:31 INFO - 'HOME': '/home/cltbld', 04:41:31 INFO - 'LANG': 'en_US.UTF-8', 04:41:31 INFO - 'LANGUAGE': 'en_US:en', 04:41:31 INFO - 'LOGNAME': 'cltbld', 04:41:31 INFO - 'MAIL': '/var/mail/cltbld', 04:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:31 INFO - 'MOZ_NO_REMOTE': '1', 04:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:31 INFO - 'NO_EM_RESTART': '1', 04:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:31 INFO - 'PWD': '/builds/slave/test', 04:41:31 INFO - 'SHELL': '/bin/bash', 04:41:31 INFO - 'SHLVL': '1', 04:41:31 INFO - 'TERM': 'linux', 04:41:31 INFO - 'TMOUT': '86400', 04:41:31 INFO - 'USER': 'cltbld', 04:41:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:31 INFO - '_': '/tools/buildbot/bin/python'} 04:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:31 INFO - Downloading/unpacking psutil>=3.1.1 04:41:31 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 04:41:31 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 04:41:31 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 04:41:31 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 04:41:31 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 04:41:31 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 04:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:41:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:33 INFO - Installing collected packages: psutil 04:41:33 INFO - Running setup.py install for psutil 04:41:33 INFO - building 'psutil._psutil_linux' extension 04:41:33 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 04:41:34 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 04:41:34 INFO - building 'psutil._psutil_posix' extension 04:41:34 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 04:41:34 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 04:41:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:34 INFO - Successfully installed psutil 04:41:34 INFO - Cleaning up... 04:41:34 INFO - Return code: 0 04:41:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 04:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 04:41:34 INFO - Using env: {'DISPLAY': ':0', 04:41:34 INFO - 'HOME': '/home/cltbld', 04:41:34 INFO - 'LANG': 'en_US.UTF-8', 04:41:34 INFO - 'LANGUAGE': 'en_US:en', 04:41:34 INFO - 'LOGNAME': 'cltbld', 04:41:34 INFO - 'MAIL': '/var/mail/cltbld', 04:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:34 INFO - 'MOZ_NO_REMOTE': '1', 04:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:34 INFO - 'NO_EM_RESTART': '1', 04:41:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:34 INFO - 'PWD': '/builds/slave/test', 04:41:34 INFO - 'SHELL': '/bin/bash', 04:41:34 INFO - 'SHLVL': '1', 04:41:34 INFO - 'TERM': 'linux', 04:41:34 INFO - 'TMOUT': '86400', 04:41:34 INFO - 'USER': 'cltbld', 04:41:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:34 INFO - '_': '/tools/buildbot/bin/python'} 04:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:41:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:41:36 INFO - Installing collected packages: mozsystemmonitor 04:41:36 INFO - Running setup.py install for mozsystemmonitor 04:41:36 INFO - Successfully installed mozsystemmonitor 04:41:36 INFO - Cleaning up... 04:41:36 INFO - Return code: 0 04:41:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 04:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 04:41:36 INFO - Using env: {'DISPLAY': ':0', 04:41:36 INFO - 'HOME': '/home/cltbld', 04:41:36 INFO - 'LANG': 'en_US.UTF-8', 04:41:36 INFO - 'LANGUAGE': 'en_US:en', 04:41:36 INFO - 'LOGNAME': 'cltbld', 04:41:36 INFO - 'MAIL': '/var/mail/cltbld', 04:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:36 INFO - 'MOZ_NO_REMOTE': '1', 04:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:36 INFO - 'NO_EM_RESTART': '1', 04:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:36 INFO - 'PWD': '/builds/slave/test', 04:41:36 INFO - 'SHELL': '/bin/bash', 04:41:36 INFO - 'SHLVL': '1', 04:41:36 INFO - 'TERM': 'linux', 04:41:36 INFO - 'TMOUT': '86400', 04:41:36 INFO - 'USER': 'cltbld', 04:41:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:36 INFO - '_': '/tools/buildbot/bin/python'} 04:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:39 INFO - warning: no files found matching '*.txt' 04:41:39 INFO - no previously-included directories found matching 'build' 04:41:39 INFO - no previously-included directories found matching 'dist' 04:41:39 INFO - no previously-included directories found matching '.git*' 04:41:39 INFO - Installing collected packages: jsonschema, functools32 04:41:39 INFO - Running setup.py install for functools32 04:41:39 INFO - warning: no files found matching '*.txt' 04:41:39 INFO - no previously-included directories found matching 'build' 04:41:39 INFO - no previously-included directories found matching 'dist' 04:41:39 INFO - no previously-included directories found matching '.git*' 04:41:39 INFO - Successfully installed jsonschema functools32 04:41:39 INFO - Cleaning up... 04:41:39 INFO - Return code: 0 04:41:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:41:39 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')]} 04:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:39 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')]} 04:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:41:39 INFO - Using env: {'DISPLAY': ':0', 04:41:39 INFO - 'HOME': '/home/cltbld', 04:41:39 INFO - 'LANG': 'en_US.UTF-8', 04:41:39 INFO - 'LANGUAGE': 'en_US:en', 04:41:39 INFO - 'LOGNAME': 'cltbld', 04:41:39 INFO - 'MAIL': '/var/mail/cltbld', 04:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:39 INFO - 'MOZ_NO_REMOTE': '1', 04:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:39 INFO - 'NO_EM_RESTART': '1', 04:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:39 INFO - 'PWD': '/builds/slave/test', 04:41:39 INFO - 'SHELL': '/bin/bash', 04:41:39 INFO - 'SHLVL': '1', 04:41:39 INFO - 'TERM': 'linux', 04:41:39 INFO - 'TMOUT': '86400', 04:41:39 INFO - 'USER': 'cltbld', 04:41:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:39 INFO - '_': '/tools/buildbot/bin/python'} 04:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:41:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41: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 04:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:41:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:42 INFO - Downloading docopt-0.6.1.tar.gz 04:41:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:41:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:41:42 INFO - Running setup.py install for blobuploader 04:41:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:41:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:41:42 INFO - Running setup.py install for requests 04:41:42 INFO - Running setup.py install for docopt 04:41:42 INFO - Successfully installed blobuploader requests docopt 04:41:42 INFO - Cleaning up... 04:41:42 INFO - Return code: 0 04:41:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 04:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 04:41:42 INFO - Using env: {'DISPLAY': ':0', 04:41:42 INFO - 'HOME': '/home/cltbld', 04:41:42 INFO - 'LANG': 'en_US.UTF-8', 04:41:42 INFO - 'LANGUAGE': 'en_US:en', 04:41:42 INFO - 'LOGNAME': 'cltbld', 04:41:42 INFO - 'MAIL': '/var/mail/cltbld', 04:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:42 INFO - 'MOZ_NO_REMOTE': '1', 04:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:42 INFO - 'NO_EM_RESTART': '1', 04:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:42 INFO - 'PWD': '/builds/slave/test', 04:41:42 INFO - 'SHELL': '/bin/bash', 04:41:42 INFO - 'SHLVL': '1', 04:41:42 INFO - 'TERM': 'linux', 04:41:42 INFO - 'TMOUT': '86400', 04:41:42 INFO - 'USER': 'cltbld', 04:41:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:42 INFO - '_': '/tools/buildbot/bin/python'} 04:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:43 INFO - Running setup.py (path:/tmp/pip-6PMw08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:43 INFO - Running setup.py (path:/tmp/pip-ph30PR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:43 INFO - Running setup.py (path:/tmp/pip-D0LOrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:43 INFO - Running setup.py (path:/tmp/pip-HjsStx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:43 INFO - Running setup.py (path:/tmp/pip-jQbCUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:43 INFO - Running setup.py (path:/tmp/pip-pW8d69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:43 INFO - Running setup.py (path:/tmp/pip-Dg6sYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:43 INFO - Running setup.py (path:/tmp/pip-xiz_zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:43 INFO - Running setup.py (path:/tmp/pip-YnHlzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:43 INFO - Running setup.py (path:/tmp/pip-owsOxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:43 INFO - Running setup.py (path:/tmp/pip-AWltE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:43 INFO - Running setup.py (path:/tmp/pip-SDg9oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:44 INFO - Running setup.py (path:/tmp/pip-Yjrs9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:44 INFO - Running setup.py (path:/tmp/pip-4b_ucF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:44 INFO - Running setup.py (path:/tmp/pip-yyv2qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:44 INFO - Running setup.py (path:/tmp/pip-W7kXj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:44 INFO - Running setup.py (path:/tmp/pip-u_ZcQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:41:44 INFO - Running setup.py install for manifestparser 04:41:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:41:44 INFO - Running setup.py install for mozcrash 04:41:44 INFO - Running setup.py install for mozdebug 04:41:44 INFO - Running setup.py install for mozdevice 04:41:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:41:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:41:44 INFO - Running setup.py install for mozfile 04:41:44 INFO - Running setup.py install for mozhttpd 04:41:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:41:44 INFO - Running setup.py install for mozinfo 04:41:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Running setup.py install for mozInstall 04:41:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Running setup.py install for mozleak 04:41:45 INFO - Running setup.py install for mozlog 04:41:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Running setup.py install for moznetwork 04:41:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Running setup.py install for mozprocess 04:41:45 INFO - Running setup.py install for mozprofile 04:41:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Running setup.py install for mozrunner 04:41:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:41:45 INFO - Running setup.py install for mozscreenshot 04:41:45 INFO - Running setup.py install for moztest 04:41:46 INFO - Running setup.py install for mozversion 04:41:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:41:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:41:46 INFO - Cleaning up... 04:41:46 INFO - Return code: 0 04:41:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:41:46 INFO - Using env: {'DISPLAY': ':0', 04:41:46 INFO - 'HOME': '/home/cltbld', 04:41:46 INFO - 'LANG': 'en_US.UTF-8', 04:41:46 INFO - 'LANGUAGE': 'en_US:en', 04:41:46 INFO - 'LOGNAME': 'cltbld', 04:41:46 INFO - 'MAIL': '/var/mail/cltbld', 04:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:46 INFO - 'MOZ_NO_REMOTE': '1', 04:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:46 INFO - 'NO_EM_RESTART': '1', 04:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:46 INFO - 'PWD': '/builds/slave/test', 04:41:46 INFO - 'SHELL': '/bin/bash', 04:41:46 INFO - 'SHLVL': '1', 04:41:46 INFO - 'TERM': 'linux', 04:41:46 INFO - 'TMOUT': '86400', 04:41:46 INFO - 'USER': 'cltbld', 04:41:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:46 INFO - '_': '/tools/buildbot/bin/python'} 04:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:46 INFO - Running setup.py (path:/tmp/pip-aAPLrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:46 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)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:46 INFO - Running setup.py (path:/tmp/pip-JfnICF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:46 INFO - Running setup.py (path:/tmp/pip-T_ZkYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:46 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)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:46 INFO - Running setup.py (path:/tmp/pip-VkUVAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:46 INFO - Running setup.py (path:/tmp/pip-zgc5oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:46 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)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:46 INFO - Running setup.py (path:/tmp/pip-RnI11c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:46 INFO - Running setup.py (path:/tmp/pip-vH_0n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:46 INFO - Running setup.py (path:/tmp/pip-_Ynow2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:41:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:46 INFO - Running setup.py (path:/tmp/pip-xfbDP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:47 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:47 INFO - Running setup.py (path:/tmp/pip-j2H6us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:47 INFO - Running setup.py (path:/tmp/pip-XyxX9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:47 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:47 INFO - Running setup.py (path:/tmp/pip-MyCurI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:47 INFO - Running setup.py (path:/tmp/pip-bz5tUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:47 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:47 INFO - Running setup.py (path:/tmp/pip-Fqxinn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:47 INFO - Running setup.py (path:/tmp/pip-2tW6dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:47 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:47 INFO - Running setup.py (path:/tmp/pip-2r66pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:47 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)) 04:41:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:47 INFO - Running setup.py (path:/tmp/pip-w5ANWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:47 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)) 04:41:47 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:47 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:47 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)) 04:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:41:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:41:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:49 INFO - Downloading blessings-1.6.tar.gz 04:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:49 INFO - Installing collected packages: blessings 04:41:49 INFO - Running setup.py install for blessings 04:41:49 INFO - Successfully installed blessings 04:41:49 INFO - Cleaning up... 04:41:49 INFO - Return code: 0 04:41:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:49 INFO - Reading from file tmpfile_stdout 04:41:49 INFO - Current package versions: 04:41:49 INFO - argparse == 1.2.1 04:41:49 INFO - blessings == 1.6 04:41:49 INFO - blobuploader == 1.2.4 04:41:49 INFO - docopt == 0.6.1 04:41:49 INFO - functools32 == 3.2.3-2 04:41:49 INFO - jsonschema == 2.5.1 04:41:49 INFO - manifestparser == 1.1 04:41:49 INFO - mozInstall == 1.12 04:41:49 INFO - mozcrash == 0.17 04:41:49 INFO - mozdebug == 0.1 04:41:49 INFO - mozdevice == 0.48 04:41:49 INFO - mozfile == 1.2 04:41:49 INFO - mozhttpd == 0.7 04:41:49 INFO - mozinfo == 0.9 04:41:49 INFO - mozleak == 0.1 04:41:49 INFO - mozlog == 3.3 04:41:49 INFO - moznetwork == 0.27 04:41:49 INFO - mozprocess == 0.23 04:41:49 INFO - mozprofile == 0.28 04:41:49 INFO - mozrunner == 6.12 04:41:49 INFO - mozscreenshot == 0.1 04:41:49 INFO - mozsystemmonitor == 0.3 04:41:49 INFO - moztest == 0.7 04:41:49 INFO - mozversion == 1.4 04:41:49 INFO - psutil == 3.1.1 04:41:49 INFO - requests == 1.2.3 04:41:49 INFO - wsgiref == 0.1.2 04:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:41:49 INFO - Using env: {'DISPLAY': ':0', 04:41:49 INFO - 'HOME': '/home/cltbld', 04:41:49 INFO - 'LANG': 'en_US.UTF-8', 04:41:49 INFO - 'LANGUAGE': 'en_US:en', 04:41:49 INFO - 'LOGNAME': 'cltbld', 04:41:49 INFO - 'MAIL': '/var/mail/cltbld', 04:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:49 INFO - 'MOZ_NO_REMOTE': '1', 04:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:49 INFO - 'NO_EM_RESTART': '1', 04:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:49 INFO - 'PWD': '/builds/slave/test', 04:41:49 INFO - 'SHELL': '/bin/bash', 04:41:49 INFO - 'SHLVL': '1', 04:41:49 INFO - 'TERM': 'linux', 04:41:49 INFO - 'TMOUT': '86400', 04:41:49 INFO - 'USER': 'cltbld', 04:41:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:49 INFO - '_': '/tools/buildbot/bin/python'} 04:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 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)) 04:41:50 INFO - Cleaning up... 04:41:50 INFO - Return code: 0 04:41:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x2719030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29da180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, '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': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', '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 04:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:41:50 INFO - Using env: {'DISPLAY': ':0', 04:41:50 INFO - 'HOME': '/home/cltbld', 04:41:50 INFO - 'LANG': 'en_US.UTF-8', 04:41:50 INFO - 'LANGUAGE': 'en_US:en', 04:41:50 INFO - 'LOGNAME': 'cltbld', 04:41:50 INFO - 'MAIL': '/var/mail/cltbld', 04:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:50 INFO - 'MOZ_NO_REMOTE': '1', 04:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:50 INFO - 'NO_EM_RESTART': '1', 04:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:50 INFO - 'PWD': '/builds/slave/test', 04:41:50 INFO - 'SHELL': '/bin/bash', 04:41:50 INFO - 'SHLVL': '1', 04:41:50 INFO - 'TERM': 'linux', 04:41:50 INFO - 'TMOUT': '86400', 04:41:50 INFO - 'USER': 'cltbld', 04:41:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:50 INFO - '_': '/tools/buildbot/bin/python'} 04:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:41:50 INFO - Cleaning up... 04:41:50 INFO - Return code: 0 04:41:50 INFO - Running post-action listener: _resource_record_post_action 04:41:50 INFO - Running post-action listener: _start_resource_monitoring 04:41:50 INFO - Starting resource monitoring. 04:41:50 INFO - [mozharness: 2016-07-21 11:41:50.450427Z] Finished create-virtualenv step (success) 04:41:50 INFO - [mozharness: 2016-07-21 11:41:50.450911Z] Running install step. 04:41:50 INFO - Running pre-action listener: _resource_record_pre_action 04:41:50 INFO - Running main action method: install 04:41:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:50 INFO - Reading from file tmpfile_stdout 04:41:50 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:50 INFO - Reading from file tmpfile_stdout 04:41:50 INFO - Output received: 04:41:50 INFO - Usage: mozinstall [options] installer 04:41:50 INFO - Options: 04:41:50 INFO - -h, --help show this help message and exit 04:41:50 INFO - -d DEST, --destination=DEST 04:41:50 INFO - Directory to install application into. [default: 04:41:50 INFO - "/builds/slave/test"] 04:41:50 INFO - --app=APP Application being installed. [default: firefox] 04:41:50 INFO - mkdir: /builds/slave/test/build/application 04:41:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:42:07 INFO - Reading from file tmpfile_stdout 04:42:07 INFO - Output received: 04:42:07 INFO - /builds/slave/test/build/application/firefox/firefox 04:42:07 INFO - Running post-action listener: _resource_record_post_action 04:42:07 INFO - [mozharness: 2016-07-21 11:42:07.990435Z] Finished install step (success) 04:42:07 INFO - [mozharness: 2016-07-21 11:42:07.990710Z] Running run-tests step. 04:42:07 INFO - Running pre-action listener: _resource_record_pre_action 04:42:07 INFO - Running main action method: run_tests 04:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:07 INFO - Python 2.7.3 04:42:07 INFO - Return code: 0 04:42:07 INFO - grabbing minidump binary from tooltool 04:42:07 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')]} 04:42:07 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d83b0>, '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 0x29d92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:07 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 04:42:07 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 04:42:07 INFO - Calling ['/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'] with output_timeout 600 04:42:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:08 INFO - Return code: 0 04:42:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:42:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:42:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 04:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 04:42:08 INFO - Using env: {'DISPLAY': ':0', 04:42:08 INFO - 'HOME': '/home/cltbld', 04:42:08 INFO - 'LANG': 'en_US.UTF-8', 04:42:08 INFO - 'LANGUAGE': 'en_US:en', 04:42:08 INFO - 'LOGNAME': 'cltbld', 04:42:08 INFO - 'MAIL': '/var/mail/cltbld', 04:42:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:08 INFO - 'MOZ_NO_REMOTE': '1', 04:42:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:08 INFO - 'NO_EM_RESTART': '1', 04:42:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:08 INFO - 'PWD': '/builds/slave/test', 04:42:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:08 INFO - 'SHELL': '/bin/bash', 04:42:08 INFO - 'SHLVL': '1', 04:42:08 INFO - 'TERM': 'linux', 04:42:08 INFO - 'TMOUT': '86400', 04:42:08 INFO - 'USER': 'cltbld', 04:42:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469101272.961243-360279003', 04:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:08 INFO - '_': '/tools/buildbot/bin/python'} 04:42:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 04:42:08 INFO - mozversion application_buildid: 20160721032136 04:42:08 INFO - mozversion application_changeset: c050984325e379286c1456a261b0cdc92dab89c1 04:42:08 INFO - mozversion application_display_name: Nightly 04:42:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:08 INFO - mozversion application_name: Firefox 04:42:08 INFO - mozversion application_remotingname: firefox 04:42:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:42:08 INFO - mozversion application_vendor: Mozilla 04:42:08 INFO - mozversion application_version: 50.0a1 04:42:08 INFO - mozversion platform_buildid: 20160721032136 04:42:08 INFO - mozversion platform_changeset: c050984325e379286c1456a261b0cdc92dab89c1 04:42:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:42:08 INFO - mozversion platform_version: 50.0a1 04:42:08 INFO - using testdate: 1469101328 04:42:08 INFO - actual date: 1469101328 04:42:08 INFO - starting webserver on 'localhost:47775' 04:42:08 INFO - SUITE-START | Running 2 tests 04:42:08 INFO - TEST-START | dromaeo_css 04:42:08 INFO - operating with platform_type : linux_ 04:42:08 INFO - Initialising browser for dromaeo_css test... 04:42:08 INFO - TEST-INFO | started process 7206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_TlKW/profile http://localhost:47775/getInfo.html) 04:42:12 INFO - PROCESS | 7206 | __metrics Screen width/height:1600/1200 04:42:12 INFO - PROCESS | 7206 | colorDepth:24 04:42:12 INFO - PROCESS | 7206 | Browser inner width/height: 1024/697 04:42:12 INFO - PROCESS | 7206 | __metrics 04:42:13 ERROR - PROCESS | 7206 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:42:14 INFO - TEST-INFO | 7206: exit 0 04:42:14 INFO - Browser initialized. 04:42:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:42:14 INFO - TEST-INFO | started process 7323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2_TlKW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:26 INFO - PROCESS | 7323 | RSS: Main: 166969344 04:42:26 INFO - PROCESS | 7323 | 04:43:15 INFO - PROCESS | 7323 | 1469101395936 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] 04:45:24 INFO - PROCESS | 7323 | Cycle 1(1): loaded http://localhost:47775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47775/tests/dromaeo/cssquery-ext.html) 04:45:25 INFO - PROCESS | 7323 | RSS: Main: 172048384 04:45:25 INFO - PROCESS | 7323 | 04:48:27 INFO - PROCESS | 7323 | Cycle 1(1): loaded http://localhost:47775/tests/dromaeo/cssquery-ext.html (next: http://localhost:47775/tests/dromaeo/cssquery-jquery.html) 04:48:28 INFO - PROCESS | 7323 | RSS: Main: 169488384 04:48:28 INFO - PROCESS | 7323 | 04:51:30 INFO - PROCESS | 7323 | Cycle 1(1): loaded http://localhost:47775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47775/tests/dromaeo/cssquery-mootools.html) 04:51:30 INFO - PROCESS | 7323 | RSS: Main: 173096960 04:51:30 INFO - PROCESS | 7323 | 04:54:32 INFO - PROCESS | 7323 | Cycle 1(1): loaded http://localhost:47775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47775/tests/dromaeo/cssquery-prototype.html) 04:54:33 INFO - PROCESS | 7323 | RSS: Main: 167591936 04:54:33 INFO - PROCESS | 7323 | 04:57:35 INFO - PROCESS | 7323 | Cycle 1(1): loaded http://localhost:47775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47775/tests/dromaeo/cssquery-yui.html) 04:57:36 INFO - PROCESS | 7323 | RSS: Main: 169627648 04:57:36 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | Cycle 1(1): loaded http://localhost:47775/tests/dromaeo/cssquery-yui.html (next: http://localhost:47775/tests/dromaeo/cssquery-dojo.html) 05:00:39 INFO - PROCESS | 7323 | RSS: Main: 170651648 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | __start_tp_report 05:00:39 INFO - PROCESS | 7323 | _x_x_mozilla_page_load 05:00:39 INFO - PROCESS | 7323 | _x_x_mozilla_page_load_details 05:00:39 INFO - PROCESS | 7323 | |i|pagename|runs| 05:00:39 INFO - PROCESS | 7323 | |0;dojo.html;3100.844957752112;3103.860326285317;3127.8592463339146;3128.5307203919424;3130.0140455756436;5408.4050754416985;5431.619786614939;5487.36895257045;5513.2005859150395;5519.144532597454;5372.167314066326;5439.292891924054;5462.235287059815;5480.451954804517;5527.585431092674;4938.604911607072;4965.3048573199785;5048.873778155539;5085.516875896784;5156.407013193474;4931.112399768041;5157.871053223662;5159.458256883029;5173.275741396207;5175.327207463025;4845.515448455161;4922.606191504671;4961.454240033575;4982.800687972477;5040.1935690289565;4916.680415772963;4945.258211268302;4965.428975667808;4967.205247160437;5016.423111342206;4997;5001.424836143854;5008.924866127011;5018.874528136826;5033.119204139298;5342.225377320306;5434.972825135888;5464.043792336365;5484.067708489566;5517.200005999108;5820.330661973842;5829.067349224104;5829.300483941912;5832.62087964281;5873.618214816066;5819.854503637401;5844.941550584483;5845.7369418376275;5853.268341457318;5864.6187997780435;5260.2372655965055;5397.10947693634;5425.9728701356635;5484.2047903053835;5494.340679118492;5988.161657367972;6038.124471951543;6056.182415373956;6059.848503787441;6080.2399700037495;5737.741801618937;5778.508826749773;5786.276715410574;5805.767769289181;5809.912851307234;5724.942750572441;5794.159846822187;5825.417458254141;5829.300483941955;5860.413958604106;5639.689817060101;5701.743421546041;5849.912251316234;5851.414858514115;5894.764209431661;5776.3068431787615;5778.162166485836;5806.767729290866;5828.76684932598;5880.323762767251;4304.698671093056;4325.048489332342;4341.218580655513;4483.865484035484;4495.3032279996;3818.0073180973145;3882.941755873664;3915.1190982028816;3921.5490218624655;3926.2932672118723;5363.570914326844;5424.701641409761;5451.918221226685;5452.127659574449;5452.945470545323;5661.1508273758445;5679.858003549944;5713.200151978726;5718.914216286759;5725.427457254241;5607.663540187602;5629.718514074362;5659.773609055592;5686.829395118153;5739.483446489836;5088.160453525127;5121.257417674491;5122.487751224848;5133.512316329943;5141.151709967813;6000.279966404059;6144.815655530341;6146.446819786241;6148.077788331697;6160.353162917829;5795.246617939557;5813.15709222152;5826.650400975955;5872.0898260769645;5904.911426328523;5995.5803093783015;6032.607880487754;6043.486303664062;6044.184035155197;6049.334573197033;5680.971595141998;5732.59871808986;5736.483716465538;5737.540996720169;5740.167675687086;5748.137779333133;5748.626339287933;5800.854978625568;5836.387179346278;5892.1161825726485;5629.915551266652;5674.886502269849;5677.120046392815;5698.572607054404;5710.314762228559;5611.775528978958;5668.688222147822;5669.54643628517;5672.234248376416;5680.375158732453;5669.121286200645;5699.572532060195;5753.079507278815;5777.45114214149;5788.479036886701;5778.971105144447;5785.161151633074;5798.33319168301;5822.621529600562;5867.530597552271;5566.332040155207;5591.9720401397735;5670.234518340137;5705.714714264187;5714.514266287412 05:00:39 INFO - PROCESS | 7323 | |1;ext.html;548.3447280499802;594.7769586405099;602.786010966107;617.8023032629558;635.5201822623918;39269.60730392699;44314.11371772567;44443;44582.554174458324;44731;43399.56600433995;43622.56377436225;43831.561684383145;44028.55971440284;44168.779156104174;8936.91063089369;9116.544172791368;9133.406328588653;9135.725928222131;9150.771230719252;8964.327675424336;9046.86429703555;9055.27557795378;9055.27557795378;9069.365144439891;9106.908930910673;9146.405483643575;9149.725508234764;9151.084891510862;9153.08469153086;9059.456432614032;9086.500242486694;9100.590473428678;9103.817923641556;9125.49809760463;8953.10468953106;8998.59506322217;9049.728508144766;9069.59186836594;9079.954600227024;42153.789231053954;42236.57763422388;42633;42716.359254611205;42777;3384.1032126486502;3618.4029635110173;3646.5988741238443;4039.2325458162854;4106.527749308838;33188.83405582957;33474;33500.329993399995;33513.32973340544;34197.658023419695;4383.693141480097;4400.779961001937;4500.662450316239;4543.5456454354635;4627.907441851178;367092;368848;370624;370753;372392.99999999726;59631.403685962585;59869;59976.400235997084;60092.39907600868;60112.39887601155;35905.46141807875;36035.819820901255;36061;37871.242575148346;62951;17821.554461138316;17832.643347132984;18018.549536261697;18043;18052.54868628295;13413.664658383423;13529.661758456117;13561.321933903266;13574.253416062014;13591;20005.399838004883;20062.49843753918;20177.49556261076;20253.797462025486;20411.28560500405;7138.32312882669;7190.8202294942;7257.782266532013;7313.878975097268;7404.703811847574;991.8710567626163;1125.8648962124435;1137.6416428824894;1159.7854396936593;1212.254463504938;34006.48990265148;34484;34519.3579790816;34578.30843383118;34627.30745385078;1104.812181929074;1217.9208351457128;1230.194222784078;1231.6674497885522;1237.2823762218072;17783;17951.640967180585;17962.5509362267;18073;18193.545161371072;602578;607620;609286;611529;612021;60963.695181523806;61075.08387374193;61633.69183154056;61746.38253617496;61937;1330.414617568267;1339.8727120923497;1362.863713628649;1374.2441657088561;1380.5996261084174;32131;32864.50703239405;33390.666093338754;33586.66413335933;33744;52233.21650175326;52259.73870130625;52480.737596311774;52782.472175277755;52939;485533;487829;490130;490875;491033;28481.28796780097;28536.14391568256;28813;29101;30770.692293076783;48763.756181220284;49377.259341109195;49496.25755613741;50150.74924625354;50799.746001269756;41446.79276603598;42797.35803963005;42947.78526107349;43797;43817;42878.78560607177;42940;43148.78425607852;44031.55968440403;44094.33858492061;41740.791296043324;42613.80396470215;42682;42947.57052429436;43032.78483607562;36400.81799590985;38108.80945595254;38444.42333365058;39180.60819391884;39208.80395598004;29420.411591767617;29433.411331773674;29689.554656679735;29720.702792971795;29800.850995744884 05:00:39 INFO - PROCESS | 7323 | |2;jquery.html;386.66939766499627;392.0610138717773;397.5785667192776;397.6023976023976;418.19914863037263;14115.364808583612;19056.523586910316;19778.30775922843;20406.285779997703;20413.48966275842;19386.70919936202;19774;19855.5036124097;20655.27706530272;20791.896040519776;5585.273914391123;5707.65754054756;5751.223584816038;5761.567882408836;5818.6326213339835;5732.426757324255;5750.511206547449;5752.165935939286;5787.334456537489;5798.391168927265;5646.548276137899;5681.772729090852;5766.711664416784;5766.884662306751;5781.19063331134;5554.389017208124;5647.548196144298;5696.2594862668;5761.4814666679995;5762.884742305151;4929.7781599828095;5069.391672999263;5079.74601269935;5090.872728181788;5096.464871188509;23622;23950.760492395202;24101.517969640685;24108.879455602786;24633.50732985348;2260.5930932432157;2369.561631098235;2461.6799816023804;2725.4004119093966;2984.149517387534;7451.925480745177;7524.209957954391;9563.665271715456;10006.399616022989;15223.238838058163;1957.9510512237166;2021.769072800592;2029.2187507809451;2033.9760790846585;2079.812816846476;83893.58053209695;85984;86799.56600216958;87318;88856.99999999936;10434.5826166954;10512.1590272778;11020.614278500374;11165.720856978478;11243.494042768096;14483.710325793636;14523.201223932785;14538.418463261563;14540.781888271684;14591.489297874523;8073.515589064675;8148.592570371457;8250.958745206235;8303.294219991247;8439.957800211083;7887.723929662549;8041.517508949481;8241.217084376975;8244.8351032979;8281.792955176048;4597.195490789099;4757.857264282077;4762.618990480753;4813.566778989838;4904.117258893362;1909.8651419676523;1969.5962327722782;1980.8316293114958;2028.8275496582955;2029.1173339597322;926.6061923682408;963.7253382785873;966.6568368229318;1000.474750755859;1037.6057098302597;20000;20747.896260518603;20780.480487987923;20869;20877.164913403292;946.5456580841097;958.1424624960621;971.9271054670928;991.613270824379;1004.683524689735;10851.86055464165;11030.613928512463;11507;11902.761944761229;12033.819492707617;216146;218828;218971;219911;287822;98318;98838.50580747194;99453;100375.49812251038;104408.47795760972;996.5117092624562;1024.948752562369;1042.6090216168784;1048.564845589072;1053.4364115198484;18022.639547209244;18194.181261843514;19125.330613428465;19143.23427062902;19178.520536986685;43444;44444;44873.775631121636;44949;45488.54511454976;60261;62672.373276266655;63175.368246316946;63616;66979;8450.577471126297;8690.826183476422;8727.781805454915;8767.386282960131;9054.63781448761;9663.420194788054;13309.933450332686;13529.59411217665;13734.381952812348;14212.857871421153;10595.364278143335;10663.626773062906;10920.126389888632;11986.940065299617;12121.75756484883;6501.9674901625185;11447.942760286145;11475.254108482923;11632.476538555955;12030;11994.520219191134;12172.452239649414;12243.816342754688;12343;12618;8399.950006249219;8506.319494440553;8787.077356877437;8816.779580510538;8944.060873608178;11401.543938242377;11682.182247242612;11975.820362694742;12044;12183.451744671334 05:00:39 INFO - PROCESS | 7323 | |3;mootools.html;1453.8982271241014;1476.9292263109244;1631.8204997450277;1787.177898166844;1805.9886463580403;7920.247576480239;8559.657613695452;8586.356023298247;9135.543222838856;9146.725598232048;8630.223279904807;8877.378583499158;8958.686445974392;8961.91038089619;8963.193312601865;2197.461621902632;2246;2247.370736193868;2251.898664560099;2257.525919556895;2241;2252.5832720946596;2302.3668491164894;2302.8503147295455;2311.5145819377867;2234.3297010896667;2245.135622785223;2248.910043598254;2261.027758064032;2268.2854900706225;2167.8482506224573;2186.912523499066;2188.9343319700433;2204.2505548113636;2204.79054489824;2195.2316689158665;2215.4018415027854;2216.3794137641485;2217.0355895185644;2217.667349897512;8948;9041.638334466614;9047.050059743764;9055.864162037575;9093.272538196929;5245.554127899095;5346.812861549866;5412.702301373423;5437.184422336642;5459.645123067027;3298.1589694627955;3349.7822641528464;3463.359278533454;3467.358538670354;3514.279572687593;1138.51044051058;1159.8517467706993;1166.6791632301101;1168.39243593331;1186.22895118173;12315.815262771066;12337.69155771104;12385.876141238563;12386.62840114798;12492.312922789242;4568.588827005586;4625;4800.543948324904;4806.8077276909235;4834.95165048345;10601.84097238542;10603.257771956043;10612.20408469368;10614.946925265323;10627;5437.34751829783;5439.129739241703;5439.864003399946;5446.809361672323;5448.591355648342;4456.598906098467;4837.274408838632;4934.506549345108;4963;4964.503549645079;3980.8606698765984;3985.20295940813;4084.2852500812833;4138.089620283533;4242.00312926462;1255.773960687085;1290.8709129087204;1309.299524754252;1312.1536608887213;1328.1499840102342;986.541258314887;1002.6540843409012;1021.6219998600566;1023.8157131716214;1024.3546565663733;6022.879542409215;6151.446369826737;6221.471174950089;6338.841528961812;6439.839004024843;456.36337309453125;456.7533531892807;463.59667089631563;467.56282875511505;482.55845901000896;4096.426500289962;4126.071633882412;4128.339465685536;4271.487421509439;4279.165562715303;10755.78488430227;11136.944315278533;11233.045191158679;11249.71875703114;11271.09831213501;11120.499577519031;11164.60923867677;11181.664550063511;11286.20996530235;11315.321080735182;8011.399145064143;8118.10700822909;8120.431569790177;8183.631736571869;8195.139510351446;6136.171616831849;6199.659018754011;6275.278342990432;6349.238091429058;6419.711112999833;9997.550110245202;10169.44068076263;10198.490075496047;10204;10261.538230779484;10000;10192.541335639766;10534.52594633228;10621.15030797519;10628.946855265674;7289;7856.45004849655;7972.202779721982;7996.84006319882;8128.187181282061;8870.955645221991;8919.241864441596;8923.955380223057;8945.776355590902;8947.865782013145;7499.925000749922;7553.5845528494265;7640.885386719093;7779.18318576564;7981.401394895523;7715.57564333967;7752.806179845549;7837.098733645704;7886.290233878978;8009.919900800917;7359.8160045999275;7428.554286742813;7470.813229669302;7480.2145774695055;7494.662740176815;5327.547158491417;5433.293671822637;5472.124460086367;5533.418991006048;5558.91661625084;5382.085045542189;5398.865028374322;5399.271098401666;5439.5648348132845;5506.724663766876 05:00:39 INFO - PROCESS | 7323 | |4;prototype.html;321.73617633540505;323;338.9423797954348;341.8085871911728;341.95041718950745;5391.32608423947;5521.199426083215;5579.442055794419;5658.132816170664;5688.715564221788;5513.393526712069;5561.694106824123;5563.276774019372;5567.526760225385;5594.636348637346;4376.452943382077;4380.802863871133;4381.277089280265;4391.385206071152;4391.6486681065435;4082.9183416331657;4248.383984322271;4298.140371925628;4393.450818647669;4394.626456751164;4220.556841531641;4221.016122422457;4233.618974292313;4241.406203131564;4267.679924005696;4225.450691410128;4238.830446782125;4275.123599662062;4289.991851914798;4291.399204111427;3719.6094410087094;3796.1648437343742;3798.3922572388287;3801.7528860624247;3802.524684414448;5358.624896257264;5426.375966763833;5433.972830135824;5437.564994800446;5437.673739575638;4916.729579873106;4954.900901981976;4957.5786058185095;4974.8756281093265;4983.327250821129;5581;5779.3642699303045;5793.7114839638525;5795.913061304083;5842.393341831031;4087.202995415895;4094.754314741125;4099.85650502234;4132.690048246363;4155.252054630166;5843.590948633598;6089.3910608939195;6091.690286588405;6098.14625952367;6129.540284478638;4192.580741925844;4234.87295381139;4239.3429018501565;4239.936400953989;4255.191513612465;4301.462317210348;4303.300196422396;4324.654027677778;4326.242907491176;4330.501992270866;4918.213085906238;4955.925661115086;4959.876003099951;4968.0312339093525;4981.526754958273;5537.778488860481;5633.6619802811965;5756.5682573807135;5811.506021988093;5816.76732930678;1423.7294913966314;1456.7450696128135;1458.1979911048882;1467.4130347860728;1472.786445965329;912.0879120879121;948.6679662118204;953.2374100719396;965.4400447740294;970.7767213540784;4960.461178022069;4964.255361695775;4988.603191106496;5000.824971125993;5025.311458369828;5199.428062913076;5206.71363075027;5209.895802083937;5261.973915086598;5266.473352664703;4789.832355867528;4994.175960966472;5045.8738531537;5067.670601410897;5076.93384389275;2763.875625596853;2768.986155069252;2789.7628701560593;2815.8451285179513;2830.433913217365;5283.226306189282;5390.814020915393;5418.620696551282;5430.402655707869;5485.885585810642;5099.974500127476;5243.842684719388;5276.3932147802725;5276.577873770089;5286.480059549107;5379.6234263601955;5385.68415581296;5389.757460914268;5415.756290966916;5424.593155513273;5155.664881782672;5161.66449180802;5180.870478238075;5190.688558686491;5202.2196670498215;4848.61211103118;5121.7451724327775;5145.7941682333785;5183.352080989876;5210.739463026909;5348.304720386325;5367.738581433438;5443.618946673853;5448.210009548672;5456.263404440349;3786.715996300233;3817.141143242859;3864.7970656725397;3872.5352957645264;3890.782254115127;4993.400791904995;5299.655522391032;5307.7887877833355;5951.702414879325;6052.697365131814;5918.437748414066;5928;5929.407059294036;5929.466348028698;5955.523558115254;5893.6463812171405;5898.528117750656;5899.646021238739;5921.7631294747725;5928.614640048383;5659.952908711737;5853.853653658693;5909.881802363842;5931.495822855106;5946.286445626552;5978.701064946648;5983.192269043623;5995.700214989146;5996.130561068708;6006.33930267679;5649.350324712546;5768.480836724715;5827.475527202572;5830.387809280134;5852.678102704393 05:00:39 INFO - PROCESS | 7323 | |5;yui.html;708.355396589104;719.1011235955053;760.4106817216657;764.1861417590266;897.7620930453431;15271.618209544753;16552.420665276717;16665.500034998968;16725.080120593364;16763.078030708308;14547.345369458373;15029.849701502982;15060.774088388656;15144.394224231046;15188.468403605875;812.2364976921705;825.3562221467265;827.7806381308958;828.1221904780922;829.5644786487082;791.3431851563217;805.6817557064956;831.5468069901918;835.5321020228661;840.5083026429546;860.4020205956863;867.5835598912525;870.2863651805523;870.316801310971;871.8343514732212;867.1588559097665;870.0559892516627;870.0951010948606;870.412471581683;872.7250915961451;632.9367063293633;635.3360738028771;637.9617222966637;638.2596188421455;639.076534407781;14870.330835112445;14876.256187190596;14878.181700006495;14883.10701357922;14891;14274.3576539056;14387.78418323726;14398.280085995762;14473.710525789425;14494.130352178903;12598.874011259953;12654.114212005163;12654.873451265461;12794.48822047117;13311.001674874326;3927.98036009821;3939.5863434339553;3946.9013274668364;3981.064449854282;4106.404571337169;79828.60085699534;80001.59999200025;81740.59129704314;82290.17709822884;82347.58826205891;10537;10679.519421626046;10773.892261077446;10824.13406927444;11005.834912476159;19817.60364792696;19823.60352792936;19848.305309314106;19865.404037878885;19872.50318742014;8199.549024803693;8340.457870238415;8394.8321033579;8399.62201700925;8500;4772.403449568804;4994.350734404504;5022.146235140035;5047.015831912815;5091.898162036812;3672.1737609037755;3710.8330125143893;3729.6829769469355;3743.47591337213;3778.3576791945434;617.6170774120075;620.6214209332304;622.710439645567;623.7847942459844;657.2080642825384;608.7078202462843;678.260695841535;704.9048378468943;746.1270313732946;750.4784174998324;10190.541425635864;10284.2801003929;10324.638637647646;10471;10705.9464702676;646.9644169570719;732.4360242613265;764.3464837563914;765.0742601452305;778.4511919097023;5350.250964864922;5385.219143224211;5458.754356053987;5566.192902029183;5751.942480575224;123756;128988;130449;131035;131078.34460827635;105145.47427262814;110032;114377;116262;117743;98554;98766.50616747014;99350;99836.50081749544;102658.48670756599;10594.682159535227;10679;10742.409167495864;10817.350958942488;10891.67324980252;55335.72332138474;55347;55469.72265138649;56514.15228771654;57278.71360643337;77551.61224193843;86869;87406.56296718476;90104.54947725219;91846;13000.219986800823;13166.605001849959;13183.802242966554;13204.339783010619;13247.20516768997;15336.079835209923;15370.846291536942;15527.84472155264;15634.218289085728;16486;14379.644942118808;14657.926710366806;14880;15054.397824087351;15568.29942652606;13902.513412030936;14487.92756036213;14515.637109071935;14516.419343226575;14998.475053373517;14116.788248176492;14916.403343866124;15025;15556;15589.454369097028;11346.943265283951;11633.127515436545;11920.128683771602;12153;12319;9230.353875228939;11240.381779002233;11923.184580934018;12273.815892761795;12275.377604425556 05:00:39 INFO - PROCESS | 7323 | __end_tp_report 05:00:39 INFO - PROCESS | 7323 | __start_cc_report 05:00:39 INFO - PROCESS | 7323 | _x_x_mozilla_cycle_collect,363 05:00:39 INFO - PROCESS | 7323 | __end_cc_report 05:00:39 INFO - PROCESS | 7323 | __startTimestamp1469102439300__endTimestamp 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | ------- Summary: start ------- 05:00:39 INFO - PROCESS | 7323 | Number of tests: 6 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | [#0] dojo.html Cycles:165 Average:5429.39 Median:5670.23 stddev:626.36 (11.0%) stddev-sans-first:601.06 05:00:39 INFO - PROCESS | 7323 | Values: 3100.8 3103.9 3127.9 3128.5 3130.0 5408.4 5431.6 5487.4 5513.2 5519.1 5372.2 5439.3 5462.2 5480.5 5527.6 4938.6 4965.3 5048.9 5085.5 5156.4 4931.1 5157.9 5159.5 5173.3 5175.3 4845.5 4922.6 4961.5 4982.8 5040.2 4916.7 4945.3 4965.4 4967.2 5016.4 4997.0 5001.4 5008.9 5018.9 5033.1 5342.2 5435.0 5464.0 5484.1 5517.2 5820.3 5829.1 5829.3 5832.6 5873.6 5819.9 5844.9 5845.7 5853.3 5864.6 5260.2 5397.1 5426.0 5484.2 5494.3 5988.2 6038.1 6056.2 6059.8 6080.2 5737.7 5778.5 5786.3 5805.8 5809.9 5724.9 5794.2 5825.4 5829.3 5860.4 5639.7 5701.7 5849.9 5851.4 5894.8 5776.3 5778.2 5806.8 5828.8 5880.3 4304.7 4325.0 4341.2 4483.9 4495.3 3818.0 3882.9 3915.1 3921.5 3926.3 5363.6 5424.7 5451.9 5452.1 5452.9 5661.2 5679.9 5713.2 5718.9 5725.4 5607.7 5629.7 5659.8 5686.8 5739.5 5088.2 5121.3 5122.5 5133.5 5141.2 6000.3 6144.8 6146.4 6148.1 6160.4 5795.2 5813.2 5826.7 5872.1 5904.9 5995.6 6032.6 6043.5 6044.2 6049.3 5681.0 5732.6 5736.5 5737.5 5740.2 5748.1 5748.6 5800.9 5836.4 5892.1 5629.9 5674.9 5677.1 5698.6 5710.3 5611.8 5668.7 5669.5 5672.2 5680.4 5669.1 5699.6 5753.1 5777.5 5788.5 5779.0 5785.2 5798.3 5822.6 5867.5 5566.3 5592.0 5670.2 5705.7 5714.5 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | [#1] ext.html Cycles:180 Average:64579.64 Median:42943.79 stddev:132689.50 (309.0%) stddev-sans-first:132974.63 05:00:39 INFO - PROCESS | 7323 | Values: 548.3 594.8 602.8 617.8 635.5 39269.6 44314.1 44443.0 44582.6 44731.0 43399.6 43622.6 43831.6 44028.6 44168.8 8936.9 9116.5 9133.4 9135.7 9150.8 8964.3 9046.9 9055.3 9055.3 9069.4 9106.9 9146.4 9149.7 9151.1 9153.1 9059.5 9086.5 9100.6 9103.8 9125.5 8953.1 8998.6 9049.7 9069.6 9080.0 42153.8 42236.6 42633.0 42716.4 42777.0 3384.1 3618.4 3646.6 4039.2 4106.5 33188.8 33474.0 33500.3 33513.3 34197.7 4383.7 4400.8 4500.7 4543.5 4627.9 367092.0 368848.0 370624.0 370753.0 372393.0 59631.4 59869.0 59976.4 60092.4 60112.4 35905.5 36035.8 36061.0 37871.2 62951.0 17821.6 17832.6 18018.5 18043.0 18052.5 13413.7 13529.7 13561.3 13574.3 13591.0 20005.4 20062.5 20177.5 20253.8 20411.3 7138.3 7190.8 7257.8 7313.9 7404.7 991.9 1125.9 1137.6 1159.8 1212.3 34006.5 34484.0 34519.4 34578.3 34627.3 1104.8 1217.9 1230.2 1231.7 1237.3 17783.0 17951.6 17962.6 18073.0 18193.5 602578.0 607620.0 609286.0 611529.0 612021.0 60963.7 61075.1 61633.7 61746.4 61937.0 1330.4 1339.9 1362.9 1374.2 1380.6 32131.0 32864.5 33390.7 33586.7 33744.0 52233.2 52259.7 52480.7 52782.5 52939.0 485533.0 487829.0 490130.0 490875.0 491033.0 28481.3 28536.1 28813.0 29101.0 30770.7 48763.8 49377.3 49496.3 50150.7 50799.7 41446.8 42797.4 42947.8 43797.0 43817.0 42878.8 42940.0 43148.8 44031.6 44094.3 41740.8 42613.8 42682.0 42947.6 43032.8 36400.8 38108.8 38444.4 39180.6 39208.8 29420.4 29433.4 29689.6 29720.7 29800.9 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | [#2] jquery.html Cycles:180 Average:22547.16 Median:13679.45 stddev:42245.89 (308.8%) stddev-sans-first:42331.63 05:00:39 INFO - PROCESS | 7323 | Values: 386.7 392.1 397.6 397.6 418.2 14115.4 19056.5 19778.3 20406.3 20413.5 19386.7 19774.0 19855.5 20655.3 20791.9 5585.3 5707.7 5751.2 5761.6 5818.6 5732.4 5750.5 5752.2 5787.3 5798.4 5646.5 5681.8 5766.7 5766.9 5781.2 5554.4 5647.5 5696.3 5761.5 5762.9 4929.8 5069.4 5079.7 5090.9 5096.5 23622.0 23950.8 24101.5 24108.9 24633.5 2260.6 2369.6 2461.7 2725.4 2984.1 7451.9 7524.2 9563.7 10006.4 15223.2 1958.0 2021.8 2029.2 2034.0 2079.8 83893.6 85984.0 86799.6 87318.0 88857.0 10434.6 10512.2 11020.6 11165.7 11243.5 14483.7 14523.2 14538.4 14540.8 14591.5 8073.5 8148.6 8251.0 8303.3 8440.0 7887.7 8041.5 8241.2 8244.8 8281.8 4597.2 4757.9 4762.6 4813.6 4904.1 1909.9 1969.6 1980.8 2028.8 2029.1 926.6 963.7 966.7 1000.5 1037.6 20000.0 20747.9 20780.5 20869.0 20877.2 946.5 958.1 971.9 991.6 1004.7 10851.9 11030.6 11507.0 11902.8 12033.8 216146.0 218828.0 218971.0 219911.0 287822.0 98318.0 98838.5 99453.0 100375.5 104408.5 996.5 1024.9 1042.6 1048.6 1053.4 18022.6 18194.2 19125.3 19143.2 19178.5 43444.0 44444.0 44873.8 44949.0 45488.5 60261.0 62672.4 63175.4 63616.0 66979.0 8450.6 8690.8 8727.8 8767.4 9054.6 9663.4 13309.9 13529.6 13734.4 14212.9 10595.4 10663.6 10920.1 11986.9 12121.8 6502.0 11447.9 11475.3 11632.5 12030.0 11994.5 12172.5 12243.8 12343.0 12618.0 8400.0 8506.3 8787.1 8816.8 8944.1 11401.5 11682.2 11975.8 12044.0 12183.5 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | [#3] mootools.html Cycles:180 Average:5904.85 Median:2512.67 stddev:3388.08 (134.8%) stddev-sans-first:3381.08 05:00:39 INFO - PROCESS | 7323 | Values: 1453.9 1476.9 1631.8 1787.2 1806.0 7920.2 8559.7 8586.4 9135.5 9146.7 8630.2 8877.4 8958.7 8961.9 8963.2 2197.5 2246.0 2247.4 2251.9 2257.5 2241.0 2252.6 2302.4 2302.9 2311.5 2234.3 2245.1 2248.9 2261.0 2268.3 2167.8 2186.9 2188.9 2204.3 2204.8 2195.2 2215.4 2216.4 2217.0 2217.7 8948.0 9041.6 9047.1 9055.9 9093.3 5245.6 5346.8 5412.7 5437.2 5459.6 3298.2 3349.8 3463.4 3467.4 3514.3 1138.5 1159.9 1166.7 1168.4 1186.2 12315.8 12337.7 12385.9 12386.6 12492.3 4568.6 4625.0 4800.5 4806.8 4835.0 10601.8 10603.3 10612.2 10614.9 10627.0 5437.3 5439.1 5439.9 5446.8 5448.6 4456.6 4837.3 4934.5 4963.0 4964.5 3980.9 3985.2 4084.3 4138.1 4242.0 1255.8 1290.9 1309.3 1312.2 1328.1 986.5 1002.7 1021.6 1023.8 1024.4 6022.9 6151.4 6221.5 6338.8 6439.8 456.4 456.8 463.6 467.6 482.6 4096.4 4126.1 4128.3 4271.5 4279.2 10755.8 11136.9 11233.0 11249.7 11271.1 11120.5 11164.6 11181.7 11286.2 11315.3 8011.4 8118.1 8120.4 8183.6 8195.1 6136.2 6199.7 6275.3 6349.2 6419.7 9997.6 10169.4 10198.5 10204.0 10261.5 10000.0 10192.5 10534.5 10621.2 10628.9 7289.0 7856.5 7972.2 7996.8 8128.2 8871.0 8919.2 8924.0 8945.8 8947.9 7499.9 7553.6 7640.9 7779.2 7981.4 7715.6 7752.8 7837.1 7886.3 8009.9 7359.8 7428.6 7470.8 7480.2 7494.7 5327.5 5433.3 5472.1 5533.4 5558.9 5382.1 5398.9 5399.3 5439.6 5506.7 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | [#4] prototype.html Cycles:180 Average:4692.18 Median:5200.82 stddev:1369.09 (26.3%) stddev-sans-first:1333.05 05:00:39 INFO - PROCESS | 7323 | Values: 321.7 323.0 338.9 341.8 342.0 5391.3 5521.2 5579.4 5658.1 5688.7 5513.4 5561.7 5563.3 5567.5 5594.6 4376.5 4380.8 4381.3 4391.4 4391.6 4082.9 4248.4 4298.1 4393.5 4394.6 4220.6 4221.0 4233.6 4241.4 4267.7 4225.5 4238.8 4275.1 4290.0 4291.4 3719.6 3796.2 3798.4 3801.8 3802.5 5358.6 5426.4 5434.0 5437.6 5437.7 4916.7 4954.9 4957.6 4974.9 4983.3 5581.0 5779.4 5793.7 5795.9 5842.4 4087.2 4094.8 4099.9 4132.7 4155.3 5843.6 6089.4 6091.7 6098.1 6129.5 4192.6 4234.9 4239.3 4239.9 4255.2 4301.5 4303.3 4324.7 4326.2 4330.5 4918.2 4955.9 4959.9 4968.0 4981.5 5537.8 5633.7 5756.6 5811.5 5816.8 1423.7 1456.7 1458.2 1467.4 1472.8 912.1 948.7 953.2 965.4 970.8 4960.5 4964.3 4988.6 5000.8 5025.3 5199.4 5206.7 5209.9 5262.0 5266.5 4789.8 4994.2 5045.9 5067.7 5076.9 2763.9 2769.0 2789.8 2815.8 2830.4 5283.2 5390.8 5418.6 5430.4 5485.9 5100.0 5243.8 5276.4 5276.6 5286.5 5379.6 5385.7 5389.8 5415.8 5424.6 5155.7 5161.7 5180.9 5190.7 5202.2 4848.6 5121.7 5145.8 5183.4 5210.7 5348.3 5367.7 5443.6 5448.2 5456.3 3786.7 3817.1 3864.8 3872.5 3890.8 4993.4 5299.7 5307.8 5951.7 6052.7 5918.4 5928.0 5929.4 5929.5 5955.5 5893.6 5898.5 5899.6 5921.8 5928.6 5660.0 5853.9 5909.9 5931.5 5946.3 5978.7 5983.2 5995.7 5996.1 6006.3 5649.4 5768.5 5827.5 5830.4 5852.7 05:00:39 INFO - PROCESS | 7323 | 05:00:39 INFO - PROCESS | 7323 | [#5] yui.html Cycles:180 Average:22799.00 Median:3691.50 stddev:33950.27 (919.7%) stddev-sans-first:34004.99 05:00:39 INFO - PROCESS | 7323 | Values: 708.4 719.1 760.4 764.2 897.8 15271.6 16552.4 16665.5 16725.1 16763.1 14547.3 15029.8 15060.8 15144.4 15188.5 812.2 825.4 827.8 828.1 829.6 791.3 805.7 831.5 835.5 840.5 860.4 867.6 870.3 870.3 871.8 867.2 870.1 870.1 870.4 872.7 632.9 635.3 638.0 638.3 639.1 14870.3 14876.3 14878.2 14883.1 14891.0 14274.4 14387.8 14398.3 14473.7 14494.1 12598.9 12654.1 12654.9 12794.5 13311.0 3928.0 3939.6 3946.9 3981.1 4106.4 79828.6 80001.6 81740.6 82290.2 82347.6 10537.0 10679.5 10773.9 10824.1 11005.8 19817.6 19823.6 19848.3 19865.4 19872.5 8199.5 8340.5 8394.8 8399.6 8500.0 4772.4 4994.4 5022.1 5047.0 5091.9 3672.2 3710.8 3729.7 3743.5 3778.4 617.6 620.6 622.7 623.8 657.2 608.7 678.3 704.9 746.1 750.5 10190.5 10284.3 10324.6 10471.0 10705.9 647.0 732.4 764.3 765.1 778.5 5350.3 5385.2 5458.8 5566.2 5751.9 123756.0 128988.0 130449.0 131035.0 131078.3 105145.5 110032.0 114377.0 116262.0 117743.0 98554.0 98766.5 99350.0 99836.5 102658.5 10594.7 10679.0 10742.4 10817.4 10891.7 55335.7 55347.0 55469.7 56514.2 57278.7 77551.6 86869.0 87406.6 90104.5 91846.0 13000.2 13166.6 13183.8 13204.3 13247.2 15336.1 15370.8 15527.8 15634.2 16486.0 14379.6 14657.9 14880.0 15054.4 15568.3 13902.5 14487.9 14515.6 14516.4 14998.5 14116.8 14916.4 15025.0 15556.0 15589.5 11346.9 11633.1 11920.1 12153.0 12319.0 9230.4 11240.4 11923.2 12273.8 12275.4 05:00:39 INFO - PROCESS | 7323 | -------- Summary: end -------- 05:00:39 INFO - PROCESS | 7323 | 05:00:40 INFO - TEST-INFO | 7323: exit 0 05:00:40 INFO - TEST-OK | dromaeo_css | took 1111804ms 05:00:40 INFO - TEST-START | kraken 05:00:40 INFO - operating with platform_type : linux_ 05:00:40 INFO - Initialising browser for kraken test... 05:00:40 INFO - TEST-INFO | started process 7573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi3U4Yz/profile http://localhost:47775/getInfo.html) 05:00:44 INFO - PROCESS | 7573 | __metrics Screen width/height:1600/1200 05:00:44 INFO - PROCESS | 7573 | colorDepth:24 05:00:44 INFO - PROCESS | 7573 | Browser inner width/height: 1024/697 05:00:44 INFO - PROCESS | 7573 | __metrics 05:00:45 ERROR - PROCESS | 7573 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:00:46 INFO - TEST-INFO | 7573: exit 0 05:00:46 INFO - Browser initialized. 05:00:46 INFO - Running cycle 1/1 for kraken test... 05:00:46 INFO - TEST-INFO | started process 7693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi3U4Yz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:58 INFO - PROCESS | 7693 | RSS: Main: 167051264 05:00:58 INFO - PROCESS | 7693 | 05:01:00 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47775/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:01 INFO - PROCESS | 7693 | RSS: Main: 172097536 05:01:01 INFO - PROCESS | 7693 | 05:01:04 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47775/tests/kraken/driver.html?testName=audio-dft) 05:01:04 INFO - PROCESS | 7693 | RSS: Main: 171798528 05:01:04 INFO - PROCESS | 7693 | 05:01:07 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47775/tests/kraken/driver.html?testName=audio-fft) 05:01:08 INFO - PROCESS | 7693 | RSS: Main: 167813120 05:01:08 INFO - PROCESS | 7693 | 05:01:10 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47775/tests/kraken/driver.html?testName=audio-oscillator) 05:01:11 INFO - PROCESS | 7693 | RSS: Main: 169017344 05:01:11 INFO - PROCESS | 7693 | 05:01:13 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:13 INFO - PROCESS | 7693 | RSS: Main: 168824832 05:01:13 INFO - PROCESS | 7693 | 05:01:16 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47775/tests/kraken/driver.html?testName=imaging-darkroom) 05:01:17 INFO - PROCESS | 7693 | RSS: Main: 169521152 05:01:17 INFO - PROCESS | 7693 | 05:01:21 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47775/tests/kraken/driver.html?testName=imaging-desaturate) 05:01:21 INFO - PROCESS | 7693 | RSS: Main: 167624704 05:01:21 INFO - PROCESS | 7693 | 05:01:24 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47775/tests/kraken/driver.html?testName=json-parse-financial) 05:01:25 INFO - PROCESS | 7693 | RSS: Main: 168370176 05:01:25 INFO - PROCESS | 7693 | 05:01:26 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:01:27 INFO - PROCESS | 7693 | RSS: Main: 168640512 05:01:27 INFO - PROCESS | 7693 | 05:01:29 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:01:29 INFO - PROCESS | 7693 | RSS: Main: 169144320 05:01:29 INFO - PROCESS | 7693 | 05:01:31 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:01:32 INFO - PROCESS | 7693 | RSS: Main: 169525248 05:01:32 INFO - PROCESS | 7693 | 05:01:35 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:01:35 INFO - PROCESS | 7693 | RSS: Main: 169431040 05:01:35 INFO - PROCESS | 7693 | 05:01:38 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:01:39 INFO - PROCESS | 7693 | RSS: Main: 169304064 05:01:39 INFO - PROCESS | 7693 | 05:01:40 INFO - PROCESS | 7693 | Cycle 1(1): loaded http://localhost:47775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47775/tests/kraken/driver.html?testName=ai-astar) 05:01:41 INFO - PROCESS | 7693 | RSS: Main: 169684992 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | __start_tp_report 05:01:41 INFO - PROCESS | 7693 | _x_x_mozilla_page_load 05:01:41 INFO - PROCESS | 7693 | _x_x_mozilla_page_load_details 05:01:41 INFO - PROCESS | 7693 | |i|pagename|runs| 05:01:41 INFO - PROCESS | 7693 | |0;ai-astar;105;111;108;113;113;114;116;112;110;111 05:01:41 INFO - PROCESS | 7693 | |1;audio-beat-detection;147;118;146;178;118;150;148;120;181;118 05:01:41 INFO - PROCESS | 7693 | |2;audio-dft;164;163;163;162;164;165;177;165;162;161 05:01:41 INFO - PROCESS | 7693 | |3;audio-fft;76;77;77;156;78;76;74;75;169;75 05:01:41 INFO - PROCESS | 7693 | |4;audio-oscillator;84;83;143;84;84;85;140;86;84;154 05:01:41 INFO - PROCESS | 7693 | |5;imaging-gaussian-blur;117;118;119;119;118;117;118;117;118;118 05:01:41 INFO - PROCESS | 7693 | |6;imaging-darkroom;148;155;148;149;148;147;148;148;147;146 05:01:41 INFO - PROCESS | 7693 | |7;imaging-desaturate;97;96;96;95;96;96;95;96;96;95 05:01:41 INFO - PROCESS | 7693 | |8;json-parse-financial;54;52;52;55;54;52;52;56;52;53 05:01:41 INFO - PROCESS | 7693 | |9;json-stringify-tinderbox;62;63;61;61;61;61;61;62;61;62 05:01:41 INFO - PROCESS | 7693 | |10;stanford-crypto-aes;78;78;75;82;75;77;82;76;80;78 05:01:41 INFO - PROCESS | 7693 | |11;stanford-crypto-ccm;121;120;124;131;130;131;127;133;162;121 05:01:41 INFO - PROCESS | 7693 | |12;stanford-crypto-pbkdf2;158;157;162;158;161;158;165;164;163;163 05:01:41 INFO - PROCESS | 7693 | |13;stanford-crypto-sha256-iterative;69;66;64;64;64;68;63;66;64;63 05:01:41 INFO - PROCESS | 7693 | __end_tp_report 05:01:41 INFO - PROCESS | 7693 | __start_cc_report 05:01:41 INFO - PROCESS | 7693 | _x_x_mozilla_cycle_collect,926 05:01:41 INFO - PROCESS | 7693 | __end_cc_report 05:01:41 INFO - PROCESS | 7693 | __startTimestamp1469102501093__endTimestamp 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | ------- Summary: start ------- 05:01:41 INFO - PROCESS | 7693 | Number of tests: 14 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.13 (2.8%) stddev-sans-first:2.35 05:01:41 INFO - PROCESS | 7693 | Values: 105.0 111.0 108.0 113.0 113.0 114.0 116.0 112.0 110.0 111.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:147.50 stddev:23.96 (16.2%) stddev-sans-first:25.36 05:01:41 INFO - PROCESS | 7693 | Values: 147.0 118.0 146.0 178.0 118.0 150.0 148.0 120.0 181.0 118.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:4.55 (2.8%) stddev-sans-first:4.82 05:01:41 INFO - PROCESS | 7693 | Values: 164.0 163.0 163.0 162.0 164.0 165.0 177.0 165.0 162.0 161.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.62 (48.2%) stddev-sans-first:38.30 05:01:41 INFO - PROCESS | 7693 | Values: 76.0 77.0 77.0 156.0 78.0 76.0 74.0 75.0 169.0 75.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.00 stddev:29.86 (35.6%) stddev-sans-first:30.90 05:01:41 INFO - PROCESS | 7693 | Values: 84.0 83.0 143.0 84.0 84.0 85.0 140.0 86.0 84.0 154.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 05:01:41 INFO - PROCESS | 7693 | Values: 117.0 118.0 119.0 119.0 118.0 117.0 118.0 117.0 118.0 118.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:2.46 (1.7%) stddev-sans-first:2.60 05:01:41 INFO - PROCESS | 7693 | Values: 148.0 155.0 148.0 149.0 148.0 147.0 148.0 148.0 147.0 146.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 05:01:41 INFO - PROCESS | 7693 | Values: 97.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.48 (2.8%) stddev-sans-first:1.54 05:01:41 INFO - PROCESS | 7693 | Values: 54.0 52.0 52.0 55.0 54.0 52.0 52.0 56.0 52.0 53.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 05:01:41 INFO - PROCESS | 7693 | Values: 62.0 63.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 62.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:2.56 (3.3%) stddev-sans-first:2.71 05:01:41 INFO - PROCESS | 7693 | Values: 78.0 78.0 75.0 82.0 75.0 77.0 82.0 76.0 80.0 78.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:130.50 stddev:12.21 (9.4%) stddev-sans-first:12.51 05:01:41 INFO - PROCESS | 7693 | Values: 121.0 120.0 124.0 131.0 130.0 131.0 127.0 133.0 162.0 121.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.50 stddev:2.92 (1.8%) stddev-sans-first:2.91 05:01:41 INFO - PROCESS | 7693 | Values: 158.0 157.0 162.0 158.0 161.0 158.0 165.0 164.0 163.0 163.0 05:01:41 INFO - PROCESS | 7693 | 05:01:41 INFO - PROCESS | 7693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:2.08 (3.2%) stddev-sans-first:1.66 05:01:41 INFO - PROCESS | 7693 | Values: 69.0 66.0 64.0 64.0 64.0 68.0 63.0 66.0 64.0 63.0 05:01:41 INFO - PROCESS | 7693 | -------- Summary: end -------- 05:01:41 INFO - PROCESS | 7693 | 05:01:42 INFO - TEST-INFO | 7693: exit 0 05:01:42 INFO - TEST-OK | kraken | took 62041ms 05:01:42 INFO - SUITE-END | took 1173s 05:01:42 INFO - Completed test suite (00:19:33) 05:01:42 INFO - javascript benchmark 05:01:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7368.886248952996, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.844957752112, 3103.860326285317, 3127.8592463339146, 3128.5307203919424, 3130.0140455756436, 5408.4050754416985, 5431.619786614939, 5487.36895257045, 5513.2005859150395, 5519.144532597454, 5372.167314066326, 5439.292891924054, 5462.235287059815, 5480.451954804517, 5527.585431092674, 4938.604911607072, 4965.3048573199785, 5048.873778155539, 5085.516875896784, 5156.407013193474, 4931.112399768041, 5157.871053223662, 5159.458256883029, 5173.275741396207, 5175.327207463025, 4845.515448455161, 4922.606191504671, 4961.454240033575, 4982.800687972477, 5040.1935690289565, 4916.680415772963, 4945.258211268302, 4965.428975667808, 4967.205247160437, 5016.423111342206, 4997.0, 5001.424836143854, 5008.924866127011, 5018.874528136826, 5033.119204139298, 5342.225377320306, 5434.972825135888, 5464.043792336365, 5484.067708489566, 5517.200005999108, 5820.330661973842, 5829.067349224104, 5829.300483941912, 5832.62087964281, 5873.618214816066, 5819.854503637401, 5844.941550584483, 5845.7369418376275, 5853.268341457318, 5864.6187997780435, 5260.2372655965055, 5397.10947693634, 5425.9728701356635, 5484.2047903053835, 5494.340679118492, 5988.161657367972, 6038.124471951543, 6056.182415373956, 6059.848503787441, 6080.2399700037495, 5737.741801618937, 5778.508826749773, 5786.276715410574, 5805.767769289181, 5809.912851307234, 5724.942750572441, 5794.159846822187, 5825.417458254141, 5829.300483941955, 5860.413958604106, 5639.689817060101, 5701.743421546041, 5849.912251316234, 5851.414858514115, 5894.764209431661, 5776.3068431787615, 5778.162166485836, 5806.767729290866, 5828.76684932598, 5880.323762767251, 4304.698671093056, 4325.048489332342, 4341.218580655513, 4483.865484035484, 4495.3032279996, 3818.0073180973145, 3882.941755873664, 3915.1190982028816, 3921.5490218624655, 3926.2932672118723, 5363.570914326844, 5424.701641409761, 5451.918221226685, 5452.127659574449, 5452.945470545323, 5661.1508273758445, 5679.858003549944, 5713.200151978726, 5718.914216286759, 5725.427457254241, 5607.663540187602, 5629.718514074362, 5659.773609055592, 5686.829395118153, 5739.483446489836, 5088.160453525127, 5121.257417674491, 5122.487751224848, 5133.512316329943, 5141.151709967813, 6000.279966404059, 6144.815655530341, 6146.446819786241, 6148.077788331697, 6160.353162917829, 5795.246617939557, 5813.15709222152, 5826.650400975955, 5872.0898260769645, 5904.911426328523, 5995.5803093783015, 6032.607880487754, 6043.486303664062, 6044.184035155197, 6049.334573197033, 5680.971595141998, 5732.59871808986, 5736.483716465538, 5737.540996720169, 5740.167675687086, 5748.137779333133, 5748.626339287933, 5800.854978625568, 5836.387179346278, 5892.1161825726485, 5629.915551266652, 5674.886502269849, 5677.120046392815, 5698.572607054404, 5710.314762228559, 5611.775528978958, 5668.688222147822, 5669.54643628517, 5672.234248376416, 5680.375158732453, 5669.121286200645, 5699.572532060195, 5753.079507278815, 5777.45114214149, 5788.479036886701, 5778.971105144447, 5785.161151633074, 5798.33319168301, 5822.621529600562, 5867.530597552271, 5566.332040155207, 5591.9720401397735, 5670.234518340137, 5705.714714264187, 5714.514266287412], "value": 5385.867461043627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.3447280499802, 594.7769586405099, 602.786010966107, 617.8023032629558, 635.5201822623918, 39269.60730392699, 44314.11371772567, 44443.0, 44582.554174458324, 44731.0, 43399.56600433995, 43622.56377436225, 43831.561684383145, 44028.55971440284, 44168.779156104174, 8936.91063089369, 9116.544172791368, 9133.406328588653, 9135.725928222131, 9150.771230719252, 8964.327675424336, 9046.86429703555, 9055.27557795378, 9055.27557795378, 9069.365144439891, 9106.908930910673, 9146.405483643575, 9149.725508234764, 9151.084891510862, 9153.08469153086, 9059.456432614032, 9086.500242486694, 9100.590473428678, 9103.817923641556, 9125.49809760463, 8953.10468953106, 8998.59506322217, 9049.728508144766, 9069.59186836594, 9079.954600227024, 42153.789231053954, 42236.57763422388, 42633.0, 42716.359254611205, 42777.0, 3384.1032126486502, 3618.4029635110173, 3646.5988741238443, 4039.2325458162854, 4106.527749308838, 33188.83405582957, 33474.0, 33500.329993399995, 33513.32973340544, 34197.658023419695, 4383.693141480097, 4400.779961001937, 4500.662450316239, 4543.5456454354635, 4627.907441851178, 367092.0, 368848.0, 370624.0, 370753.0, 372392.99999999726, 59631.403685962585, 59869.0, 59976.400235997084, 60092.39907600868, 60112.39887601155, 35905.46141807875, 36035.819820901255, 36061.0, 37871.242575148346, 62951.0, 17821.554461138316, 17832.643347132984, 18018.549536261697, 18043.0, 18052.54868628295, 13413.664658383423, 13529.661758456117, 13561.321933903266, 13574.253416062014, 13591.0, 20005.399838004883, 20062.49843753918, 20177.49556261076, 20253.797462025486, 20411.28560500405, 7138.32312882669, 7190.8202294942, 7257.782266532013, 7313.878975097268, 7404.703811847574, 991.8710567626163, 1125.8648962124435, 1137.6416428824894, 1159.7854396936593, 1212.254463504938, 34006.48990265148, 34484.0, 34519.3579790816, 34578.30843383118, 34627.30745385078, 1104.812181929074, 1217.9208351457128, 1230.194222784078, 1231.6674497885522, 1237.2823762218072, 17783.0, 17951.640967180585, 17962.5509362267, 18073.0, 18193.545161371072, 602578.0, 607620.0, 609286.0, 611529.0, 612021.0, 60963.695181523806, 61075.08387374193, 61633.69183154056, 61746.38253617496, 61937.0, 1330.414617568267, 1339.8727120923497, 1362.863713628649, 1374.2441657088561, 1380.5996261084174, 32131.0, 32864.50703239405, 33390.666093338754, 33586.66413335933, 33744.0, 52233.21650175326, 52259.73870130625, 52480.737596311774, 52782.472175277755, 52939.0, 485533.0, 487829.0, 490130.0, 490875.0, 491033.0, 28481.28796780097, 28536.14391568256, 28813.0, 29101.0, 30770.692293076783, 48763.756181220284, 49377.259341109195, 49496.25755613741, 50150.74924625354, 50799.746001269756, 41446.79276603598, 42797.35803963005, 42947.78526107349, 43797.0, 43817.0, 42878.78560607177, 42940.0, 43148.78425607852, 44031.55968440403, 44094.33858492061, 41740.791296043324, 42613.80396470215, 42682.0, 42947.57052429436, 43032.78483607562, 36400.81799590985, 38108.80945595254, 38444.42333365058, 39180.60819391884, 39208.80395598004, 29420.411591767617, 29433.411331773674, 29689.554656679735, 29720.702792971795, 29800.850995744884], "value": 20767.646643918353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.66939766499627, 392.0610138717773, 397.5785667192776, 397.6023976023976, 418.19914863037263, 14115.364808583612, 19056.523586910316, 19778.30775922843, 20406.285779997703, 20413.48966275842, 19386.70919936202, 19774.0, 19855.5036124097, 20655.27706530272, 20791.896040519776, 5585.273914391123, 5707.65754054756, 5751.223584816038, 5761.567882408836, 5818.6326213339835, 5732.426757324255, 5750.511206547449, 5752.165935939286, 5787.334456537489, 5798.391168927265, 5646.548276137899, 5681.772729090852, 5766.711664416784, 5766.884662306751, 5781.19063331134, 5554.389017208124, 5647.548196144298, 5696.2594862668, 5761.4814666679995, 5762.884742305151, 4929.7781599828095, 5069.391672999263, 5079.74601269935, 5090.872728181788, 5096.464871188509, 23622.0, 23950.760492395202, 24101.517969640685, 24108.879455602786, 24633.50732985348, 2260.5930932432157, 2369.561631098235, 2461.6799816023804, 2725.4004119093966, 2984.149517387534, 7451.925480745177, 7524.209957954391, 9563.665271715456, 10006.399616022989, 15223.238838058163, 1957.9510512237166, 2021.769072800592, 2029.2187507809451, 2033.9760790846585, 2079.812816846476, 83893.58053209695, 85984.0, 86799.56600216958, 87318.0, 88856.99999999936, 10434.5826166954, 10512.1590272778, 11020.614278500374, 11165.720856978478, 11243.494042768096, 14483.710325793636, 14523.201223932785, 14538.418463261563, 14540.781888271684, 14591.489297874523, 8073.515589064675, 8148.592570371457, 8250.958745206235, 8303.294219991247, 8439.957800211083, 7887.723929662549, 8041.517508949481, 8241.217084376975, 8244.8351032979, 8281.792955176048, 4597.195490789099, 4757.857264282077, 4762.618990480753, 4813.566778989838, 4904.117258893362, 1909.8651419676523, 1969.5962327722782, 1980.8316293114958, 2028.8275496582955, 2029.1173339597322, 926.6061923682408, 963.7253382785873, 966.6568368229318, 1000.474750755859, 1037.6057098302597, 20000.0, 20747.896260518603, 20780.480487987923, 20869.0, 20877.164913403292, 946.5456580841097, 958.1424624960621, 971.9271054670928, 991.613270824379, 1004.683524689735, 10851.86055464165, 11030.613928512463, 11507.0, 11902.761944761229, 12033.819492707617, 216146.0, 218828.0, 218971.0, 219911.0, 287822.0, 98318.0, 98838.50580747194, 99453.0, 100375.49812251038, 104408.47795760972, 996.5117092624562, 1024.948752562369, 1042.6090216168784, 1048.564845589072, 1053.4364115198484, 18022.639547209244, 18194.181261843514, 19125.330613428465, 19143.23427062902, 19178.520536986685, 43444.0, 44444.0, 44873.775631121636, 44949.0, 45488.54511454976, 60261.0, 62672.373276266655, 63175.368246316946, 63616.0, 66979.0, 8450.577471126297, 8690.826183476422, 8727.781805454915, 8767.386282960131, 9054.63781448761, 9663.420194788054, 13309.933450332686, 13529.59411217665, 13734.381952812348, 14212.857871421153, 10595.364278143335, 10663.626773062906, 10920.126389888632, 11986.940065299617, 12121.75756484883, 6501.9674901625185, 11447.942760286145, 11475.254108482923, 11632.476538555955, 12030.0, 11994.520219191134, 12172.452239649414, 12243.816342754688, 12343.0, 12618.0, 8399.950006249219, 8506.319494440553, 8787.077356877437, 8816.779580510538, 8944.060873608178, 11401.543938242377, 11682.182247242612, 11975.820362694742, 12044.0, 12183.451744671334], "value": 9165.399141191332, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.8982271241014, 1476.9292263109244, 1631.8204997450277, 1787.177898166844, 1805.9886463580403, 7920.247576480239, 8559.657613695452, 8586.356023298247, 9135.543222838856, 9146.725598232048, 8630.223279904807, 8877.378583499158, 8958.686445974392, 8961.91038089619, 8963.193312601865, 2197.461621902632, 2246.0, 2247.370736193868, 2251.898664560099, 2257.525919556895, 2241.0, 2252.5832720946596, 2302.3668491164894, 2302.8503147295455, 2311.5145819377867, 2234.3297010896667, 2245.135622785223, 2248.910043598254, 2261.027758064032, 2268.2854900706225, 2167.8482506224573, 2186.912523499066, 2188.9343319700433, 2204.2505548113636, 2204.79054489824, 2195.2316689158665, 2215.4018415027854, 2216.3794137641485, 2217.0355895185644, 2217.667349897512, 8948.0, 9041.638334466614, 9047.050059743764, 9055.864162037575, 9093.272538196929, 5245.554127899095, 5346.812861549866, 5412.702301373423, 5437.184422336642, 5459.645123067027, 3298.1589694627955, 3349.7822641528464, 3463.359278533454, 3467.358538670354, 3514.279572687593, 1138.51044051058, 1159.8517467706993, 1166.6791632301101, 1168.39243593331, 1186.22895118173, 12315.815262771066, 12337.69155771104, 12385.876141238563, 12386.62840114798, 12492.312922789242, 4568.588827005586, 4625.0, 4800.543948324904, 4806.8077276909235, 4834.95165048345, 10601.84097238542, 10603.257771956043, 10612.20408469368, 10614.946925265323, 10627.0, 5437.34751829783, 5439.129739241703, 5439.864003399946, 5446.809361672323, 5448.591355648342, 4456.598906098467, 4837.274408838632, 4934.506549345108, 4963.0, 4964.503549645079, 3980.8606698765984, 3985.20295940813, 4084.2852500812833, 4138.089620283533, 4242.00312926462, 1255.773960687085, 1290.8709129087204, 1309.299524754252, 1312.1536608887213, 1328.1499840102342, 986.541258314887, 1002.6540843409012, 1021.6219998600566, 1023.8157131716214, 1024.3546565663733, 6022.879542409215, 6151.446369826737, 6221.471174950089, 6338.841528961812, 6439.839004024843, 456.36337309453125, 456.7533531892807, 463.59667089631563, 467.56282875511505, 482.55845901000896, 4096.426500289962, 4126.071633882412, 4128.339465685536, 4271.487421509439, 4279.165562715303, 10755.78488430227, 11136.944315278533, 11233.045191158679, 11249.71875703114, 11271.09831213501, 11120.499577519031, 11164.60923867677, 11181.664550063511, 11286.20996530235, 11315.321080735182, 8011.399145064143, 8118.10700822909, 8120.431569790177, 8183.631736571869, 8195.139510351446, 6136.171616831849, 6199.659018754011, 6275.278342990432, 6349.238091429058, 6419.711112999833, 9997.550110245202, 10169.44068076263, 10198.490075496047, 10204.0, 10261.538230779484, 10000.0, 10192.541335639766, 10534.52594633228, 10621.15030797519, 10628.946855265674, 7289.0, 7856.45004849655, 7972.202779721982, 7996.84006319882, 8128.187181282061, 8870.955645221991, 8919.241864441596, 8923.955380223057, 8945.776355590902, 8947.865782013145, 7499.925000749922, 7553.5845528494265, 7640.885386719093, 7779.18318576564, 7981.401394895523, 7715.57564333967, 7752.806179845549, 7837.098733645704, 7886.290233878978, 8009.919900800917, 7359.8160045999275, 7428.554286742813, 7470.813229669302, 7480.2145774695055, 7494.662740176815, 5327.547158491417, 5433.293671822637, 5472.124460086367, 5533.418991006048, 5558.91661625084, 5382.085045542189, 5398.865028374322, 5399.271098401666, 5439.5648348132845, 5506.724663766876], "value": 4629.091420682591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.73617633540505, 323.0, 338.9423797954348, 341.8085871911728, 341.95041718950745, 5391.32608423947, 5521.199426083215, 5579.442055794419, 5658.132816170664, 5688.715564221788, 5513.393526712069, 5561.694106824123, 5563.276774019372, 5567.526760225385, 5594.636348637346, 4376.452943382077, 4380.802863871133, 4381.277089280265, 4391.385206071152, 4391.6486681065435, 4082.9183416331657, 4248.383984322271, 4298.140371925628, 4393.450818647669, 4394.626456751164, 4220.556841531641, 4221.016122422457, 4233.618974292313, 4241.406203131564, 4267.679924005696, 4225.450691410128, 4238.830446782125, 4275.123599662062, 4289.991851914798, 4291.399204111427, 3719.6094410087094, 3796.1648437343742, 3798.3922572388287, 3801.7528860624247, 3802.524684414448, 5358.624896257264, 5426.375966763833, 5433.972830135824, 5437.564994800446, 5437.673739575638, 4916.729579873106, 4954.900901981976, 4957.5786058185095, 4974.8756281093265, 4983.327250821129, 5581.0, 5779.3642699303045, 5793.7114839638525, 5795.913061304083, 5842.393341831031, 4087.202995415895, 4094.754314741125, 4099.85650502234, 4132.690048246363, 4155.252054630166, 5843.590948633598, 6089.3910608939195, 6091.690286588405, 6098.14625952367, 6129.540284478638, 4192.580741925844, 4234.87295381139, 4239.3429018501565, 4239.936400953989, 4255.191513612465, 4301.462317210348, 4303.300196422396, 4324.654027677778, 4326.242907491176, 4330.501992270866, 4918.213085906238, 4955.925661115086, 4959.876003099951, 4968.0312339093525, 4981.526754958273, 5537.778488860481, 5633.6619802811965, 5756.5682573807135, 5811.506021988093, 5816.76732930678, 1423.7294913966314, 1456.7450696128135, 1458.1979911048882, 1467.4130347860728, 1472.786445965329, 912.0879120879121, 948.6679662118204, 953.2374100719396, 965.4400447740294, 970.7767213540784, 4960.461178022069, 4964.255361695775, 4988.603191106496, 5000.824971125993, 5025.311458369828, 5199.428062913076, 5206.71363075027, 5209.895802083937, 5261.973915086598, 5266.473352664703, 4789.832355867528, 4994.175960966472, 5045.8738531537, 5067.670601410897, 5076.93384389275, 2763.875625596853, 2768.986155069252, 2789.7628701560593, 2815.8451285179513, 2830.433913217365, 5283.226306189282, 5390.814020915393, 5418.620696551282, 5430.402655707869, 5485.885585810642, 5099.974500127476, 5243.842684719388, 5276.3932147802725, 5276.577873770089, 5286.480059549107, 5379.6234263601955, 5385.68415581296, 5389.757460914268, 5415.756290966916, 5424.593155513273, 5155.664881782672, 5161.66449180802, 5180.870478238075, 5190.688558686491, 5202.2196670498215, 4848.61211103118, 5121.7451724327775, 5145.7941682333785, 5183.352080989876, 5210.739463026909, 5348.304720386325, 5367.738581433438, 5443.618946673853, 5448.210009548672, 5456.263404440349, 3786.715996300233, 3817.141143242859, 3864.7970656725397, 3872.5352957645264, 3890.782254115127, 4993.400791904995, 5299.655522391032, 5307.7887877833355, 5951.702414879325, 6052.697365131814, 5918.437748414066, 5928.0, 5929.407059294036, 5929.466348028698, 5955.523558115254, 5893.6463812171405, 5898.528117750656, 5899.646021238739, 5921.7631294747725, 5928.614640048383, 5659.952908711737, 5853.853653658693, 5909.881802363842, 5931.495822855106, 5946.286445626552, 5978.701064946648, 5983.192269043623, 5995.700214989146, 5996.130561068708, 6006.33930267679, 5649.350324712546, 5768.480836724715, 5827.475527202572, 5830.387809280134, 5852.678102704393], "value": 4255.885680523333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.355396589104, 719.1011235955053, 760.4106817216657, 764.1861417590266, 897.7620930453431, 15271.618209544753, 16552.420665276717, 16665.500034998968, 16725.080120593364, 16763.078030708308, 14547.345369458373, 15029.849701502982, 15060.774088388656, 15144.394224231046, 15188.468403605875, 812.2364976921705, 825.3562221467265, 827.7806381308958, 828.1221904780922, 829.5644786487082, 791.3431851563217, 805.6817557064956, 831.5468069901918, 835.5321020228661, 840.5083026429546, 860.4020205956863, 867.5835598912525, 870.2863651805523, 870.316801310971, 871.8343514732212, 867.1588559097665, 870.0559892516627, 870.0951010948606, 870.412471581683, 872.7250915961451, 632.9367063293633, 635.3360738028771, 637.9617222966637, 638.2596188421455, 639.076534407781, 14870.330835112445, 14876.256187190596, 14878.181700006495, 14883.10701357922, 14891.0, 14274.3576539056, 14387.78418323726, 14398.280085995762, 14473.710525789425, 14494.130352178903, 12598.874011259953, 12654.114212005163, 12654.873451265461, 12794.48822047117, 13311.001674874326, 3927.98036009821, 3939.5863434339553, 3946.9013274668364, 3981.064449854282, 4106.404571337169, 79828.60085699534, 80001.59999200025, 81740.59129704314, 82290.17709822884, 82347.58826205891, 10537.0, 10679.519421626046, 10773.892261077446, 10824.13406927444, 11005.834912476159, 19817.60364792696, 19823.60352792936, 19848.305309314106, 19865.404037878885, 19872.50318742014, 8199.549024803693, 8340.457870238415, 8394.8321033579, 8399.62201700925, 8500.0, 4772.403449568804, 4994.350734404504, 5022.146235140035, 5047.015831912815, 5091.898162036812, 3672.1737609037755, 3710.8330125143893, 3729.6829769469355, 3743.47591337213, 3778.3576791945434, 617.6170774120075, 620.6214209332304, 622.710439645567, 623.7847942459844, 657.2080642825384, 608.7078202462843, 678.260695841535, 704.9048378468943, 746.1270313732946, 750.4784174998324, 10190.541425635864, 10284.2801003929, 10324.638637647646, 10471.0, 10705.9464702676, 646.9644169570719, 732.4360242613265, 764.3464837563914, 765.0742601452305, 778.4511919097023, 5350.250964864922, 5385.219143224211, 5458.754356053987, 5566.192902029183, 5751.942480575224, 123756.0, 128988.0, 130449.0, 131035.0, 131078.34460827635, 105145.47427262814, 110032.0, 114377.0, 116262.0, 117743.0, 98554.0, 98766.50616747014, 99350.0, 99836.50081749544, 102658.48670756599, 10594.682159535227, 10679.0, 10742.409167495864, 10817.350958942488, 10891.67324980252, 55335.72332138474, 55347.0, 55469.72265138649, 56514.15228771654, 57278.71360643337, 77551.61224193843, 86869.0, 87406.56296718476, 90104.54947725219, 91846.0, 13000.219986800823, 13166.605001849959, 13183.802242966554, 13204.339783010619, 13247.20516768997, 15336.079835209923, 15370.846291536942, 15527.84472155264, 15634.218289085728, 16486.0, 14379.644942118808, 14657.926710366806, 14880.0, 15054.397824087351, 15568.29942652606, 13902.513412030936, 14487.92756036213, 14515.637109071935, 14516.419343226575, 14998.475053373517, 14116.788248176492, 14916.403343866124, 15025.0, 15556.0, 15589.454369097028, 11346.943265283951, 11633.127515436545, 11920.128683771602, 12153.0, 12319.0, 9230.353875228939, 11240.381779002233, 11923.184580934018, 12273.815892761795, 12275.377604425556], "value": 7926.566673430348, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 108.0, 113.0, 113.0, 114.0, 116.0, 112.0, 110.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 146.0, 178.0, 118.0, 150.0, 148.0, 120.0, 181.0, 118.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 164.0, 165.0, 177.0, 165.0, 162.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 156.0, 78.0, 76.0, 74.0, 75.0, 169.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 143.0, 84.0, 84.0, 85.0, 140.0, 86.0, 84.0, 154.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 155.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 147.0, 146.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 55.0, 54.0, 52.0, 52.0, 56.0, 52.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 75.0, 82.0, 75.0, 77.0, 82.0, 76.0, 80.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 124.0, 131.0, 130.0, 131.0, 127.0, 133.0, 162.0, 121.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 162.0, 158.0, 161.0, 158.0, 165.0, 164.0, 163.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 64.0, 64.0, 64.0, 68.0, 63.0, 66.0, 64.0, 63.0], "value": 65.1, "unit": "score"}]}]} 05:01:42 INFO - Return code: 0 05:01:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:01:42 ERROR - # TBPL SUCCESS # 05:01:42 INFO - Running post-action listener: _resource_record_post_action 05:01:42 INFO - [mozharness: 2016-07-21 12:01:42.377302Z] Finished run-tests step (success) 05:01:42 INFO - Running post-run listener: _resource_record_post_run 05:01:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553275392; Read time: 12; Write time: 503640 05:01:42 INFO - TinderboxPrint: CPU usage
13.4% 05:01:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:01:42 INFO - TinderboxPrint: I/O write bytes / time
553,275,392 / 503,640 05:01:42 INFO - TinderboxPrint: CPU idle
8,225.7 (86.5%) 05:01:42 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 05:01:42 INFO - TinderboxPrint: Swap in / out
0 / 0 05:01:42 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257167360; Read time: 0; Write time: 294860 05:01:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296108032; Read time: 0; Write time: 208780 05:01:43 INFO - Running post-run listener: _upload_blobber_files 05:01:43 INFO - Blob upload gear active. 05:01:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:01:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:01:43 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:01:43 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:01:43 INFO - (blobuploader) - INFO - Open directory for files ... 05:01:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:01:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:01:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:44 INFO - (blobuploader) - INFO - Done attempting. 05:01:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:01:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:01:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:56 INFO - (blobuploader) - INFO - Done attempting. 05:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:57 INFO - (blobuploader) - INFO - Done attempting. 05:01:57 INFO - (blobuploader) - INFO - Iteration through files over. 05:01:57 INFO - Return code: 0 05:01:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:01:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:01:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c11be4dc21e6ef009ebf3620a9311fb546b986c15f05e970cea39960e0045f2b884f26811c07a04ff579bbdb356517437d0b0325b920afdbaa5a81d1910f5b60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88374a930bd32022d7b0a008defb007f85172066baf96c983d13a6b14ddf86078f4fdd26e2c7186b303179a288d04680626af53df00c44cb236b25a8cc10a93b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2497b0d03e09534557b1d9d22464183dfa51077b2428498ceeeaa52ec01d3fd5f70ed56f6a94e3874da8a8ac7c51c0052cd7a4c5ce327cfa9a5f0e00679b806e"} 05:01:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:01:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:01:57 INFO - Contents: 05:01:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c11be4dc21e6ef009ebf3620a9311fb546b986c15f05e970cea39960e0045f2b884f26811c07a04ff579bbdb356517437d0b0325b920afdbaa5a81d1910f5b60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88374a930bd32022d7b0a008defb007f85172066baf96c983d13a6b14ddf86078f4fdd26e2c7186b303179a288d04680626af53df00c44cb236b25a8cc10a93b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2497b0d03e09534557b1d9d22464183dfa51077b2428498ceeeaa52ec01d3fd5f70ed56f6a94e3874da8a8ac7c51c0052cd7a4c5ce327cfa9a5f0e00679b806e"} 05:01:57 INFO - Running post-run listener: copy_logs_to_upload_dir 05:01:57 INFO - Copying logs to upload dir... 05:01:57 INFO - mkdir: /builds/slave/test/build/upload/logs 05:01:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.115009 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-21 05:01:56.791018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:01:56.794706) ========= 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=d2a8c569965ab8367867b893000001a1-1469101272.961243-360279003 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/sha512/c11be4dc21e6ef009ebf3620a9311fb546b986c15f05e970cea39960e0045f2b884f26811c07a04ff579bbdb356517437d0b0325b920afdbaa5a81d1910f5b60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88374a930bd32022d7b0a008defb007f85172066baf96c983d13a6b14ddf86078f4fdd26e2c7186b303179a288d04680626af53df00c44cb236b25a8cc10a93b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2497b0d03e09534557b1d9d22464183dfa51077b2428498ceeeaa52ec01d3fd5f70ed56f6a94e3874da8a8ac7c51c0052cd7a4c5ce327cfa9a5f0e00679b806e"} build_url:https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010326 build_url: 'https://queue.taskcluster.net/v1/task/QXDEStzIT9avsMVy3jkaxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c11be4dc21e6ef009ebf3620a9311fb546b986c15f05e970cea39960e0045f2b884f26811c07a04ff579bbdb356517437d0b0325b920afdbaa5a81d1910f5b60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/88374a930bd32022d7b0a008defb007f85172066baf96c983d13a6b14ddf86078f4fdd26e2c7186b303179a288d04680626af53df00c44cb236b25a8cc10a93b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2497b0d03e09534557b1d9d22464183dfa51077b2428498ceeeaa52ec01d3fd5f70ed56f6a94e3874da8a8ac7c51c0052cd7a4c5ce327cfa9a5f0e00679b806e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 05:01:56.817927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:01:56.818266) ========= 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=d2a8c569965ab8367867b893000001a1-1469101272.961243-360279003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 05:01:56.867163) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:01:56.867487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 05:01:56.867817) ========= ========= Total master_lag: 0.38 =========