builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1472582424.42 results: success (0) buildid: 20160830083013 builduid: dc145c91d0a240ffa8fe62803315f36c revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.421622) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.421989) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.422288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.466349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.466620) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 11:40:24-- 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% 229M=0s 2016-08-30 11:40:24 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.643172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.643462) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.071715 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.728039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:24.728402) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b18c8bcdc116eef8799880b7c50317bf54218474 --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 b18c8bcdc116eef8799880b7c50317bf54218474 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 11:40:25,082 truncating revision to first 12 chars 2016-08-30 11:40:25,082 Setting DEBUG logging. 2016-08-30 11:40:25,082 attempt 1/10 2016-08-30 11:40:25,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b18c8bcdc116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 11:40:25,352 unpacking tar archive at: fx-team-b18c8bcdc116/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584343 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:25.326436) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:25.326750) ========= script_repo_revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:25.327163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:25.327444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 11:40:25.337667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-30 11:40:25.337977) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:25 INFO - MultiFileLogger online at 20160830 11:40:25 in /builds/slave/test 11:40:25 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 11:40:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:25 INFO - {'append_to_log': False, 11:40:25 INFO - 'base_work_dir': '/builds/slave/test', 11:40:25 INFO - 'blob_upload_branch': 'Fx-Team', 11:40:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:25 INFO - 'branch': 'Fx-Team', 11:40:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:25 INFO - 'config_files': ('talos/linux_config.py',), 11:40:25 INFO - 'default_actions': ('clobber', 11:40:25 INFO - 'read-buildbot-config', 11:40:25 INFO - 'download-and-extract', 11:40:25 INFO - 'populate-webroot', 11:40:25 INFO - 'create-virtualenv', 11:40:25 INFO - 'install', 11:40:25 INFO - 'run-tests'), 11:40:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:25 INFO - 'download_minidump_stackwalk': True, 11:40:25 INFO - 'download_symbols': 'ondemand', 11:40:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:25 INFO - 'installer_path': 'installer.exe', 11:40:25 INFO - 'log_level': 'info', 11:40:25 INFO - 'log_name': 'talos', 11:40:25 INFO - 'log_to_console': True, 11:40:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:25 INFO - 'opt_config_files': (), 11:40:25 INFO - 'pip_index': False, 11:40:25 INFO - 'sps_profile': False, 11:40:25 INFO - 'sps_profile_interval': 0, 11:40:25 INFO - 'suite': 'dromaeojs-e10s', 11:40:25 INFO - 'system_bits': '32', 11:40:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:25 INFO - 'title': 'talos-linux64-ix-042', 11:40:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:25 INFO - 'use_talos_json': True, 11:40:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:25 INFO - 'work_dir': 'build'} 11:40:25 INFO - [mozharness: 2016-08-30 18:40:25.883706Z] Running clobber step. 11:40:25 INFO - Running pre-action listener: _resource_record_pre_action 11:40:25 INFO - Running main action method: clobber 11:40:25 INFO - rmtree: /builds/slave/test/build 11:40:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:26 INFO - Running post-action listener: _resource_record_post_action 11:40:26 INFO - [mozharness: 2016-08-30 18:40:26.606754Z] Finished clobber step (success) 11:40:26 INFO - [mozharness: 2016-08-30 18:40:26.606855Z] Running read-buildbot-config step. 11:40:26 INFO - Running pre-action listener: _resource_record_pre_action 11:40:26 INFO - Running main action method: read_buildbot_config 11:40:26 INFO - Using buildbot properties: 11:40:26 INFO - { 11:40:26 INFO - "project": "", 11:40:26 INFO - "product": "firefox", 11:40:26 INFO - "script_repo_revision": "production", 11:40:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:40:26 INFO - "repository": "", 11:40:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:40:26 INFO - "buildid": "20160830083013", 11:40:26 INFO - "pgo_build": "True", 11:40:26 INFO - "basedir": "/builds/slave/test", 11:40:26 INFO - "buildnumber": 717, 11:40:26 INFO - "slavename": "talos-linux64-ix-042", 11:40:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:40:26 INFO - "platform": "ubuntu64_hw", 11:40:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:40:26 INFO - "branch": "fx-team", 11:40:26 INFO - "repo_path": "integration/fx-team", 11:40:26 INFO - "revision": "b18c8bcdc116eef8799880b7c50317bf54218474", 11:40:26 INFO - "stage_platform": "linux64-pgo", 11:40:26 INFO - "builduid": "dc145c91d0a240ffa8fe62803315f36c", 11:40:26 INFO - "slavebuilddir": "test" 11:40:26 INFO - } 11:40:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:40:26 INFO - Running post-action listener: _resource_record_post_action 11:40:26 INFO - [mozharness: 2016-08-30 18:40:26.609482Z] Finished read-buildbot-config step (success) 11:40:26 INFO - [mozharness: 2016-08-30 18:40:26.609575Z] Running download-and-extract step. 11:40:26 INFO - Running pre-action listener: _resource_record_pre_action 11:40:26 INFO - Running main action method: download_and_extract 11:40:26 INFO - mkdir: /builds/slave/test/build/tests 11:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:26 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:40:26 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:40:27 INFO - Downloaded 1361 bytes. 11:40:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:40:27 INFO - Using the following test package requirements: 11:40:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:40:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:40:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:40:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'jsshell-linux-x86_64.zip'], 11:40:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:40:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:40:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:40:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:40:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:40:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:40:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:40:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:40:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:27 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:40:27 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:40:28 INFO - Downloaded 21886963 bytes. 11:40:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:40:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:32 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:40:32 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:40:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:40:33 INFO - Downloaded 21886963 bytes. 11:40:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:38 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:40:38 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:40:38 INFO - Downloaded 14413998 bytes. 11:40:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:39 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:40:39 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:40:40 INFO - Downloaded 59736493 bytes. 11:40:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:40:40 INFO - mkdir: /builds/slave/test/properties 11:40:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:40:40 INFO - Writing to file /builds/slave/test/properties/build_url 11:40:40 INFO - Contents: 11:40:40 INFO - build_url:https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:40:41 INFO - Running post-action listener: _resource_record_post_action 11:40:41 INFO - Running post-action listener: set_extra_try_arguments 11:40:41 INFO - [mozharness: 2016-08-30 18:40:41.482342Z] Finished download-and-extract step (success) 11:40:41 INFO - [mozharness: 2016-08-30 18:40:41.482568Z] Running populate-webroot step. 11:40:41 INFO - Running pre-action listener: _resource_record_pre_action 11:40:41 INFO - Running main action method: populate_webroot 11:40:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:40:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:40:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:40:41 INFO - '--tppagecycles', 11:40:41 INFO - '7'], 11:40:41 INFO - 'tests': ['tsvgm']}}, 11:40:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:40:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:40:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:40:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:40:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['damp', 'tps']}, 11:40:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'tests': ['damp', 'tps']}, 11:40:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['dromaeo_dom']}, 11:40:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:40:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['basic_compositor_video']}, 11:40:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:40:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['a11yr', 11:40:41 INFO - 'ts_paint', 11:40:41 INFO - 'tpaint', 11:40:41 INFO - 'sessionrestore', 11:40:41 INFO - 'sessionrestore_no_auto_restore', 11:40:41 INFO - 'tabpaint']}, 11:40:41 INFO - 'other-e10s': {'tests': ['a11yr', 11:40:41 INFO - 'ts_paint', 11:40:41 INFO - 'tpaint', 11:40:41 INFO - 'sessionrestore', 11:40:41 INFO - 'sessionrestore_no_auto_restore', 11:40:41 INFO - 'tabpaint']}, 11:40:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:40:41 INFO - 'ts_paint', 11:40:41 INFO - 'tpaint', 11:40:41 INFO - 'sessionrestore', 11:40:41 INFO - 'sessionrestore_no_auto_restore', 11:40:41 INFO - 'tabpaint']}, 11:40:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:40:41 INFO - 'ts_paint', 11:40:41 INFO - 'tpaint', 11:40:41 INFO - 'sessionrestore', 11:40:41 INFO - 'sessionrestore_no_auto_restore', 11:40:41 INFO - 'tabpaint']}, 11:40:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['a11yr', 11:40:41 INFO - 'ts_paint', 11:40:41 INFO - 'tpaint', 11:40:41 INFO - 'sessionrestore', 11:40:41 INFO - 'sessionrestore_no_auto_restore', 11:40:41 INFO - 'tabpaint']}, 11:40:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['a11yr', 11:40:41 INFO - 'ts_paint', 11:40:41 INFO - 'tpaint', 11:40:41 INFO - 'sessionrestore', 11:40:41 INFO - 'sessionrestore_no_auto_restore', 11:40:41 INFO - 'tabpaint']}, 11:40:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['tsvgx', 11:40:41 INFO - 'tsvgr_opacity', 11:40:41 INFO - 'tart', 11:40:41 INFO - 'tscrollx', 11:40:41 INFO - 'cart']}, 11:40:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:40:41 INFO - 'tsvgr_opacity', 11:40:41 INFO - 'tart', 11:40:41 INFO - 'tscrollx', 11:40:41 INFO - 'cart']}, 11:40:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'talos_options': ['--disable-e10s'], 11:40:41 INFO - 'tests': ['tp5o']}, 11:40:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'tests': ['tp5o']}, 11:40:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'talos_options': ['--disable-e10s', 11:40:41 INFO - '--xperf_path', 11:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:41 INFO - 'tests': ['tp5n']}, 11:40:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:40:41 INFO - 'talos_options': ['--xperf_path', 11:40:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:41 INFO - 'tests': ['tp5n']}}, 11:40:41 INFO - 'talos.zip': {'path': '', 11:40:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:40:41 INFO - Running post-action listener: _resource_record_post_action 11:40:41 INFO - [mozharness: 2016-08-30 18:40:41.500005Z] Finished populate-webroot step (success) 11:40:41 INFO - [mozharness: 2016-08-30 18:40:41.500094Z] Running create-virtualenv step. 11:40:41 INFO - Running pre-action listener: _resource_record_pre_action 11:40:41 INFO - Running main action method: create_virtualenv 11:40:41 INFO - Creating virtualenv /builds/slave/test/build/venv 11:40:41 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 11:40:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:40:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:40:41 INFO - Using real prefix '/usr' 11:40:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:40:42 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:44 INFO - Installing pip.................done. 11:40:44 INFO - Return code: 0 11:40:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:44 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:40:44 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 11:40:44 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 11:40:44 INFO - Using env: {'DISPLAY': ':0', 11:40:44 INFO - 'HOME': '/home/cltbld', 11:40:44 INFO - 'LANG': 'en_US.UTF-8', 11:40:44 INFO - 'LANGUAGE': 'en_US:en', 11:40:44 INFO - 'LOGNAME': 'cltbld', 11:40:44 INFO - 'MAIL': '/var/mail/cltbld', 11:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:44 INFO - 'MOZ_NO_REMOTE': '1', 11:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:44 INFO - 'NO_EM_RESTART': '1', 11:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:44 INFO - 'PWD': '/builds/slave/test', 11:40:44 INFO - 'SHELL': '/bin/bash', 11:40:44 INFO - 'SHLVL': '1', 11:40:44 INFO - 'TERM': 'linux', 11:40:44 INFO - 'TMOUT': '86400', 11:40:44 INFO - 'USER': 'cltbld', 11:40:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:44 INFO - '_': '/tools/buildbot/bin/python'} 11:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:44 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 11:40:44 INFO - Cleaning up... 11:40:44 INFO - Return code: 0 11:40:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:44 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:40:44 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 11:40:44 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 11:40:44 INFO - Using env: {'DISPLAY': ':0', 11:40:44 INFO - 'HOME': '/home/cltbld', 11:40:44 INFO - 'LANG': 'en_US.UTF-8', 11:40:44 INFO - 'LANGUAGE': 'en_US:en', 11:40:44 INFO - 'LOGNAME': 'cltbld', 11:40:44 INFO - 'MAIL': '/var/mail/cltbld', 11:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:44 INFO - 'MOZ_NO_REMOTE': '1', 11:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:44 INFO - 'NO_EM_RESTART': '1', 11:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:44 INFO - 'PWD': '/builds/slave/test', 11:40:44 INFO - 'SHELL': '/bin/bash', 11:40:44 INFO - 'SHLVL': '1', 11:40:44 INFO - 'TERM': 'linux', 11:40:44 INFO - 'TMOUT': '86400', 11:40:44 INFO - 'USER': 'cltbld', 11:40:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:44 INFO - '_': '/tools/buildbot/bin/python'} 11:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:44 INFO - Downloading/unpacking psutil>=3.1.1 11:40:44 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 11:40:44 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 11:40:44 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 11:40:44 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 11:40:44 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 11:40:44 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 11:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:40:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:46 INFO - Installing collected packages: psutil 11:40:46 INFO - Running setup.py install for psutil 11:40:46 INFO - building 'psutil._psutil_linux' extension 11:40:46 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 11:40:47 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 11:40:47 INFO - building 'psutil._psutil_posix' extension 11:40:47 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 11:40:47 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 11:40:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:48 INFO - Successfully installed psutil 11:40:48 INFO - Cleaning up... 11:40:48 INFO - Return code: 0 11:40:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:40:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:48 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:40:48 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 11:40:48 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 11:40:48 INFO - Using env: {'DISPLAY': ':0', 11:40:48 INFO - 'HOME': '/home/cltbld', 11:40:48 INFO - 'LANG': 'en_US.UTF-8', 11:40:48 INFO - 'LANGUAGE': 'en_US:en', 11:40:48 INFO - 'LOGNAME': 'cltbld', 11:40:48 INFO - 'MAIL': '/var/mail/cltbld', 11:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:48 INFO - 'MOZ_NO_REMOTE': '1', 11:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:48 INFO - 'NO_EM_RESTART': '1', 11:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:48 INFO - 'PWD': '/builds/slave/test', 11:40:48 INFO - 'SHELL': '/bin/bash', 11:40:48 INFO - 'SHLVL': '1', 11:40:48 INFO - 'TERM': 'linux', 11:40:48 INFO - 'TMOUT': '86400', 11:40:48 INFO - 'USER': 'cltbld', 11:40:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:48 INFO - '_': '/tools/buildbot/bin/python'} 11:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:40:48 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 11:40:48 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 11:40:48 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 11:40:48 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 11:40:48 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 11:40:48 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 11:40:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:40:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:40:50 INFO - Installing collected packages: mozsystemmonitor 11:40:50 INFO - Running setup.py install for mozsystemmonitor 11:40:50 INFO - Successfully installed mozsystemmonitor 11:40:50 INFO - Cleaning up... 11:40:50 INFO - Return code: 0 11:40:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:40: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==2.5.1'] in /builds/slave/test/build 11:40: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==2.5.1 11:40:50 INFO - Using env: {'DISPLAY': ':0', 11:40:50 INFO - 'HOME': '/home/cltbld', 11:40:50 INFO - 'LANG': 'en_US.UTF-8', 11:40:50 INFO - 'LANGUAGE': 'en_US:en', 11:40:50 INFO - 'LOGNAME': 'cltbld', 11:40:50 INFO - 'MAIL': '/var/mail/cltbld', 11:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:50 INFO - 'MOZ_NO_REMOTE': '1', 11:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:50 INFO - 'NO_EM_RESTART': '1', 11:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:50 INFO - 'PWD': '/builds/slave/test', 11:40:50 INFO - 'SHELL': '/bin/bash', 11:40:50 INFO - 'SHLVL': '1', 11:40:50 INFO - 'TERM': 'linux', 11:40:50 INFO - 'TMOUT': '86400', 11:40:50 INFO - 'USER': 'cltbld', 11:40:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:50 INFO - '_': '/tools/buildbot/bin/python'} 11:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:40:50 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 11:40:50 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 11:40:50 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 11:40:50 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 11:40:50 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 11:40:50 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 11:40:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40:52 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 11:40:52 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 11:40:52 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 11:40:52 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 11:40:52 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 11:40:52 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 11:40:52 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:52 INFO - warning: no files found matching '*.txt' 11:40:52 INFO - no previously-included directories found matching 'build' 11:40:52 INFO - no previously-included directories found matching 'dist' 11:40:52 INFO - no previously-included directories found matching '.git*' 11:40:52 INFO - Installing collected packages: jsonschema, functools32 11:40:52 INFO - Running setup.py install for functools32 11:40:52 INFO - warning: no files found matching '*.txt' 11:40:52 INFO - no previously-included directories found matching 'build' 11:40:52 INFO - no previously-included directories found matching 'dist' 11:40:52 INFO - no previously-included directories found matching '.git*' 11:40:52 INFO - Successfully installed jsonschema functools32 11:40:52 INFO - Cleaning up... 11:40:53 INFO - Return code: 0 11:40:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:53 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:40:53 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:40:53 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 functools32==3.2.3-2 11:40:53 INFO - Using env: {'DISPLAY': ':0', 11:40:53 INFO - 'HOME': '/home/cltbld', 11:40:53 INFO - 'LANG': 'en_US.UTF-8', 11:40:53 INFO - 'LANGUAGE': 'en_US:en', 11:40:53 INFO - 'LOGNAME': 'cltbld', 11:40:53 INFO - 'MAIL': '/var/mail/cltbld', 11:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:53 INFO - 'MOZ_NO_REMOTE': '1', 11:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:53 INFO - 'NO_EM_RESTART': '1', 11:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:53 INFO - 'PWD': '/builds/slave/test', 11:40:53 INFO - 'SHELL': '/bin/bash', 11:40:53 INFO - 'SHLVL': '1', 11:40:53 INFO - 'TERM': 'linux', 11:40:53 INFO - 'TMOUT': '86400', 11:40:53 INFO - 'USER': 'cltbld', 11:40:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:53 INFO - '_': '/tools/buildbot/bin/python'} 11:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:40:53 INFO - Cleaning up... 11:40:53 INFO - Return code: 0 11:40:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:53 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:40:53 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 11:40:53 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 11:40:53 INFO - Using env: {'DISPLAY': ':0', 11:40:53 INFO - 'HOME': '/home/cltbld', 11:40:53 INFO - 'LANG': 'en_US.UTF-8', 11:40:53 INFO - 'LANGUAGE': 'en_US:en', 11:40:53 INFO - 'LOGNAME': 'cltbld', 11:40:53 INFO - 'MAIL': '/var/mail/cltbld', 11:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:53 INFO - 'MOZ_NO_REMOTE': '1', 11:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:53 INFO - 'NO_EM_RESTART': '1', 11:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:53 INFO - 'PWD': '/builds/slave/test', 11:40:53 INFO - 'SHELL': '/bin/bash', 11:40:53 INFO - 'SHLVL': '1', 11:40:53 INFO - 'TERM': 'linux', 11:40:53 INFO - 'TMOUT': '86400', 11:40:53 INFO - 'USER': 'cltbld', 11:40:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:53 INFO - '_': '/tools/buildbot/bin/python'} 11:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:56 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:57 INFO - Downloading docopt-0.6.1.tar.gz 11:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:57 INFO - Running setup.py install for blobuploader 11:40:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:57 INFO - Running setup.py install for requests 11:40:57 INFO - Running setup.py install for docopt 11:40:57 INFO - Successfully installed blobuploader requests docopt 11:40:57 INFO - Cleaning up... 11:40:57 INFO - Return code: 0 11:40:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:57 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:57 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:57 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:40:57 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 11:40:57 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 11:40:57 INFO - Using env: {'DISPLAY': ':0', 11:40:57 INFO - 'HOME': '/home/cltbld', 11:40:57 INFO - 'LANG': 'en_US.UTF-8', 11:40:57 INFO - 'LANGUAGE': 'en_US:en', 11:40:57 INFO - 'LOGNAME': 'cltbld', 11:40:57 INFO - 'MAIL': '/var/mail/cltbld', 11:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:57 INFO - 'MOZ_NO_REMOTE': '1', 11:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:57 INFO - 'NO_EM_RESTART': '1', 11:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:57 INFO - 'PWD': '/builds/slave/test', 11:40:57 INFO - 'SHELL': '/bin/bash', 11:40:57 INFO - 'SHLVL': '1', 11:40:57 INFO - 'TERM': 'linux', 11:40:57 INFO - 'TMOUT': '86400', 11:40:57 INFO - 'USER': 'cltbld', 11:40:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:57 INFO - '_': '/tools/buildbot/bin/python'} 11:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:57 INFO - Running setup.py (path:/tmp/pip-a5I7dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:58 INFO - Running setup.py (path:/tmp/pip-2s4jjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:58 INFO - Running setup.py (path:/tmp/pip-DelDjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:58 INFO - Running setup.py (path:/tmp/pip-iC211k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:58 INFO - Running setup.py (path:/tmp/pip-QqrXvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:58 INFO - Running setup.py (path:/tmp/pip-tm8qdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:58 INFO - Running setup.py (path:/tmp/pip-95bVLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:58 INFO - Running setup.py (path:/tmp/pip-U74ETJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:58 INFO - Running setup.py (path:/tmp/pip-zLeRpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:58 INFO - Running setup.py (path:/tmp/pip-mJ7LwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:58 INFO - Running setup.py (path:/tmp/pip-3gpqpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:58 INFO - Running setup.py (path:/tmp/pip-Tjrqo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:58 INFO - Running setup.py (path:/tmp/pip-do00xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:58 INFO - Running setup.py (path:/tmp/pip-dvKx1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:58 INFO - Running setup.py (path:/tmp/pip-ETZor4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:59 INFO - Running setup.py (path:/tmp/pip-UH08XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:59 INFO - Running setup.py (path:/tmp/pip-Bi6yuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:59 INFO - Running setup.py install for manifestparser 11:40:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Running setup.py install for mozcrash 11:40:59 INFO - Running setup.py install for mozdebug 11:40:59 INFO - Running setup.py install for mozdevice 11:40:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Running setup.py install for mozfile 11:40:59 INFO - Running setup.py install for mozhttpd 11:40:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Running setup.py install for mozinfo 11:40:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Running setup.py install for mozInstall 11:40:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:59 INFO - Running setup.py install for mozleak 11:41:00 INFO - Running setup.py install for mozlog 11:41:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for moznetwork 11:41:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozprocess 11:41:00 INFO - Running setup.py install for mozprofile 11:41:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozrunner 11:41:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Running setup.py install for mozscreenshot 11:41:00 INFO - Running setup.py install for moztest 11:41:00 INFO - Running setup.py install for mozversion 11:41:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:00 INFO - Cleaning up... 11:41:00 INFO - Return code: 0 11:41:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:00 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:41:00 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 11:41:00 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 11:41:00 INFO - Using env: {'DISPLAY': ':0', 11:41:00 INFO - 'HOME': '/home/cltbld', 11:41:00 INFO - 'LANG': 'en_US.UTF-8', 11:41:00 INFO - 'LANGUAGE': 'en_US:en', 11:41:00 INFO - 'LOGNAME': 'cltbld', 11:41:00 INFO - 'MAIL': '/var/mail/cltbld', 11:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:00 INFO - 'MOZ_NO_REMOTE': '1', 11:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:00 INFO - 'NO_EM_RESTART': '1', 11:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:00 INFO - 'PWD': '/builds/slave/test', 11:41:00 INFO - 'SHELL': '/bin/bash', 11:41:00 INFO - 'SHLVL': '1', 11:41:00 INFO - 'TERM': 'linux', 11:41:00 INFO - 'TMOUT': '86400', 11:41:00 INFO - 'USER': 'cltbld', 11:41:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:00 INFO - '_': '/tools/buildbot/bin/python'} 11:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:01 INFO - Running setup.py (path:/tmp/pip-duDRNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:01 INFO - Running setup.py (path:/tmp/pip-aI6mam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:01 INFO - Running setup.py (path:/tmp/pip-PV9XKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:01 INFO - Running setup.py (path:/tmp/pip-iREiHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:01 INFO - Running setup.py (path:/tmp/pip-IRdcVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:01 INFO - Running setup.py (path:/tmp/pip-uRdM0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:01 INFO - Running setup.py (path:/tmp/pip-felJe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:01 INFO - Running setup.py (path:/tmp/pip-tCXAwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:01 INFO - Running setup.py (path:/tmp/pip-EsjZxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:01 INFO - Running setup.py (path:/tmp/pip-Ho6jg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:01 INFO - Running setup.py (path:/tmp/pip-kMzSNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:01 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)) 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:01 INFO - Running setup.py (path:/tmp/pip-SFa_fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:02 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)) 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:02 INFO - Running setup.py (path:/tmp/pip-rtTIVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:02 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)) 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:02 INFO - Running setup.py (path:/tmp/pip-TNMdNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:02 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)) 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:02 INFO - Running setup.py (path:/tmp/pip-1iDeaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:02 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)) 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:02 INFO - Running setup.py (path:/tmp/pip-YTsaSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:02 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)) 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:02 INFO - Running setup.py (path:/tmp/pip-fl5Dby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:02 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)) 11:41:02 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)) 11:41:02 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)) 11:41:02 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)) 11:41:02 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)) 11:41:02 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)) 11:41:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:07 INFO - Downloading blessings-1.6.tar.gz 11:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:07 INFO - Installing collected packages: blessings 11:41:07 INFO - Running setup.py install for blessings 11:41:07 INFO - Successfully installed blessings 11:41:07 INFO - Cleaning up... 11:41:07 INFO - Return code: 0 11:41:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:07 INFO - Reading from file tmpfile_stdout 11:41:07 INFO - Current package versions: 11:41:07 INFO - argparse == 1.2.1 11:41:07 INFO - blessings == 1.6 11:41:07 INFO - blobuploader == 1.2.4 11:41:07 INFO - docopt == 0.6.1 11:41:07 INFO - functools32 == 3.2.3-2 11:41:07 INFO - jsonschema == 2.5.1 11:41:07 INFO - manifestparser == 1.1 11:41:07 INFO - mozInstall == 1.12 11:41:07 INFO - mozcrash == 0.17 11:41:07 INFO - mozdebug == 0.1 11:41:07 INFO - mozdevice == 0.48 11:41:07 INFO - mozfile == 1.2 11:41:07 INFO - mozhttpd == 0.7 11:41:07 INFO - mozinfo == 0.9 11:41:07 INFO - mozleak == 0.1 11:41:07 INFO - mozlog == 3.3 11:41:07 INFO - moznetwork == 0.27 11:41:07 INFO - mozprocess == 0.23 11:41:07 INFO - mozprofile == 0.28 11:41:07 INFO - mozrunner == 6.12 11:41:07 INFO - mozscreenshot == 0.1 11:41:07 INFO - mozsystemmonitor == 0.3 11:41:07 INFO - moztest == 0.7 11:41:07 INFO - mozversion == 1.4 11:41:07 INFO - psutil == 3.1.1 11:41:07 INFO - requests == 1.2.3 11:41:07 INFO - wsgiref == 0.1.2 11:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:07 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:41:07 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 11:41:07 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 11:41:07 INFO - Using env: {'DISPLAY': ':0', 11:41:07 INFO - 'HOME': '/home/cltbld', 11:41:07 INFO - 'LANG': 'en_US.UTF-8', 11:41:07 INFO - 'LANGUAGE': 'en_US:en', 11:41:07 INFO - 'LOGNAME': 'cltbld', 11:41:07 INFO - 'MAIL': '/var/mail/cltbld', 11:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:07 INFO - 'MOZ_NO_REMOTE': '1', 11:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:07 INFO - 'NO_EM_RESTART': '1', 11:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:07 INFO - 'PWD': '/builds/slave/test', 11:41:07 INFO - 'SHELL': '/bin/bash', 11:41:07 INFO - 'SHLVL': '1', 11:41:07 INFO - 'TERM': 'linux', 11:41:07 INFO - 'TMOUT': '86400', 11:41:07 INFO - 'USER': 'cltbld', 11:41:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:07 INFO - '_': '/tools/buildbot/bin/python'} 11:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 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)) 11:41:08 INFO - Cleaning up... 11:41:08 INFO - Return code: 0 11:41:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:08 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 0x7fb6572c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', '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 11:41:08 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 11:41:08 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 11:41:08 INFO - Using env: {'DISPLAY': ':0', 11:41:08 INFO - 'HOME': '/home/cltbld', 11:41:08 INFO - 'LANG': 'en_US.UTF-8', 11:41:08 INFO - 'LANGUAGE': 'en_US:en', 11:41:08 INFO - 'LOGNAME': 'cltbld', 11:41:08 INFO - 'MAIL': '/var/mail/cltbld', 11:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:08 INFO - 'MOZ_NO_REMOTE': '1', 11:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:08 INFO - 'NO_EM_RESTART': '1', 11:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:08 INFO - 'PWD': '/builds/slave/test', 11:41:08 INFO - 'SHELL': '/bin/bash', 11:41:08 INFO - 'SHLVL': '1', 11:41:08 INFO - 'TERM': 'linux', 11:41:08 INFO - 'TMOUT': '86400', 11:41:08 INFO - 'USER': 'cltbld', 11:41:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:08 INFO - '_': '/tools/buildbot/bin/python'} 11:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:08 INFO - Cleaning up... 11:41:08 INFO - Return code: 0 11:41:08 INFO - Running post-action listener: _resource_record_post_action 11:41:08 INFO - Running post-action listener: _start_resource_monitoring 11:41:08 INFO - Starting resource monitoring. 11:41:08 INFO - [mozharness: 2016-08-30 18:41:08.291648Z] Finished create-virtualenv step (success) 11:41:08 INFO - [mozharness: 2016-08-30 18:41:08.292585Z] Running install step. 11:41:08 INFO - Running pre-action listener: _resource_record_pre_action 11:41:08 INFO - Running main action method: install 11:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:08 INFO - Reading from file tmpfile_stdout 11:41:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:08 INFO - Reading from file tmpfile_stdout 11:41:08 INFO - Output received: 11:41:08 INFO - Usage: mozinstall [options] installer 11:41:08 INFO - Options: 11:41:08 INFO - -h, --help show this help message and exit 11:41:08 INFO - -d DEST, --destination=DEST 11:41:08 INFO - Directory to install application into. [default: 11:41:08 INFO - "/builds/slave/test"] 11:41:08 INFO - --app=APP Application being installed. [default: firefox] 11:41:08 INFO - mkdir: /builds/slave/test/build/application 11:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:41:25 INFO - Reading from file tmpfile_stdout 11:41:25 INFO - Output received: 11:41:25 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:25 INFO - Running post-action listener: _resource_record_post_action 11:41:25 INFO - [mozharness: 2016-08-30 18:41:25.588753Z] Finished install step (success) 11:41:25 INFO - [mozharness: 2016-08-30 18:41:25.589039Z] Running run-tests step. 11:41:25 INFO - Running pre-action listener: _resource_record_pre_action 11:41:25 INFO - Running main action method: run_tests 11:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:25 INFO - Python 2.7.3 11:41:25 INFO - Return code: 0 11:41:25 INFO - grabbing minidump binary from tooltool 11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:25 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 0xd94370>, '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 0xd978f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd97d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:25 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 11:41:25 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 11:41:25 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 11:41:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:25 INFO - Return code: 0 11:41:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:25 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/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:41:25 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/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:41:25 INFO - Using env: {'DISPLAY': ':0', 11:41:25 INFO - 'HOME': '/home/cltbld', 11:41:25 INFO - 'LANG': 'en_US.UTF-8', 11:41:25 INFO - 'LANGUAGE': 'en_US:en', 11:41:25 INFO - 'LOGNAME': 'cltbld', 11:41:25 INFO - 'MAIL': '/var/mail/cltbld', 11:41:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:25 INFO - 'MOZ_NO_REMOTE': '1', 11:41:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:25 INFO - 'NO_EM_RESTART': '1', 11:41:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:25 INFO - 'PWD': '/builds/slave/test', 11:41:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:25 INFO - 'SHELL': '/bin/bash', 11:41:25 INFO - 'SHLVL': '1', 11:41:25 INFO - 'TERM': 'linux', 11:41:25 INFO - 'TMOUT': '86400', 11:41:25 INFO - 'USER': 'cltbld', 11:41:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161', 11:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:25 INFO - '_': '/tools/buildbot/bin/python'} 11:41:25 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/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:41:26 INFO - mozversion application_buildid: 20160830083013 11:41:26 INFO - mozversion application_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 11:41:26 INFO - mozversion application_display_name: Nightly 11:41:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:26 INFO - mozversion application_name: Firefox 11:41:26 INFO - mozversion application_remotingname: firefox 11:41:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:41:26 INFO - mozversion application_vendor: Mozilla 11:41:26 INFO - mozversion application_version: 51.0a1 11:41:26 INFO - mozversion platform_buildid: 20160830083013 11:41:26 INFO - mozversion platform_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 11:41:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:41:26 INFO - mozversion platform_version: 51.0a1 11:41:26 INFO - using testdate: 1472582486 11:41:26 INFO - actual date: 1472582486 11:41:26 INFO - starting webserver on 'localhost:50531' 11:41:26 INFO - SUITE-START | Running 2 tests 11:41:26 INFO - TEST-START | dromaeo_css 11:41:26 INFO - operating with platform_type : linux_ 11:41:26 INFO - Initialising browser for dromaeo_css test... 11:41:26 INFO - TEST-INFO | started process 3293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiug_3/profile http://localhost:50531/getInfo.html) 11:41:32 INFO - PROCESS | 3293 | __metrics Screen width/height:1600/1200 11:41:32 INFO - PROCESS | 3293 | colorDepth:24 11:41:32 INFO - PROCESS | 3293 | Browser inner width/height: 1024/697 11:41:32 INFO - PROCESS | 3293 | __metrics 11:41:33 ERROR - PROCESS | 3293 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 11:41:34 INFO - TEST-INFO | 3293: exit 0 11:41:34 INFO - Browser initialized. 11:41:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:34 INFO - TEST-INFO | started process 3417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiug_3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:46 INFO - PROCESS | 3417 | RSS: Main: 191512576 11:41:46 INFO - PROCESS | 3417 | 11:42:35 INFO - PROCESS | 3417 | 1472582555947 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] 11:44:46 INFO - PROCESS | 3417 | Cycle 1(1): loaded http://localhost:50531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50531/tests/dromaeo/cssquery-ext.html) 11:44:47 INFO - PROCESS | 3417 | RSS: Main: 206999552 11:44:47 INFO - PROCESS | 3417 | 11:47:49 INFO - PROCESS | 3417 | Cycle 1(1): loaded http://localhost:50531/tests/dromaeo/cssquery-ext.html (next: http://localhost:50531/tests/dromaeo/cssquery-jquery.html) 11:47:50 INFO - PROCESS | 3417 | RSS: Main: 200392704 11:47:50 INFO - PROCESS | 3417 | 11:50:51 INFO - PROCESS | 3417 | Cycle 1(1): loaded http://localhost:50531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50531/tests/dromaeo/cssquery-mootools.html) 11:50:52 INFO - PROCESS | 3417 | RSS: Main: 197390336 11:50:52 INFO - PROCESS | 3417 | 11:53:54 INFO - PROCESS | 3417 | Cycle 1(1): loaded http://localhost:50531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50531/tests/dromaeo/cssquery-prototype.html) 11:53:54 INFO - PROCESS | 3417 | RSS: Main: 193925120 11:53:54 INFO - PROCESS | 3417 | 11:56:57 INFO - PROCESS | 3417 | Cycle 1(1): loaded http://localhost:50531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50531/tests/dromaeo/cssquery-yui.html) 11:56:58 INFO - PROCESS | 3417 | RSS: Main: 197283840 11:56:58 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | Cycle 1(1): loaded http://localhost:50531/tests/dromaeo/cssquery-yui.html (next: http://localhost:50531/tests/dromaeo/cssquery-dojo.html) 12:00:01 INFO - PROCESS | 3417 | RSS: Main: 197660672 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | __start_tp_report 12:00:01 INFO - PROCESS | 3417 | _x_x_mozilla_page_load 12:00:01 INFO - PROCESS | 3417 | _x_x_mozilla_page_load_details 12:00:01 INFO - PROCESS | 3417 | |i|pagename|runs| 12:00:01 INFO - PROCESS | 3417 | |0;dojo.html;3007.248187953012;3028.803127796693;3049.1919641295062;3063.1729433053074;3064.1420402287367;5287.074761916659;5476.151196564534;5502.394736578973;5521.282233309669;5536.889262214763;5466.480684334992;5498.367687715904;5533.833984980447;5562.16567514872;5572.58205634577;4914.582260507852;5004.649674522785;5017.247412888078;5054.317667114948;5094.337736094302;5025.899482010358;5039.790450291922;5051.292819005343;5100.413452452978;5103.055934652083;4620.561046700558;4885.560299573055;4951.23255895335;4955.677880937764;4987.650864439491;4829.251466022772;4835.903281934342;4846.515348465161;4940.580050695695;5031.496850314976;4812.109759694433;4864.513548645143;4866.562009419134;4880.951190488086;4899.902001959977;5290.55030322423;5332.760025798849;5388.541973932221;5407.567394608422;5443.836684899459;5808.4191580842;5831.475167234969;5838.095095260242;5841.795537156179;5873.706314684248;5821.068629019336;5844.47399734026;5859.238299021143;5873.676947767871;5881.794137205177;5186.72925133341;5342.358916929955;5353.785848566092;5399.757010934517;5480.123180291134;5779.133130030529;5852.8536786579825;5892.057270836645;5893.14549390336;5912.113183022581;5578.609497335147;5581.330240371181;5585.050541407971;5634.239377684042;5646.265985421869;5490.203920431595;5695.088785794253;5703.058995265735;5775.422457754275;5793.8551536211935;5546.168074788733;5634.070378387521;5656.773729050792;5666.660000399989;5682.914756278659;5667.093265077568;5681.659100453986;5687.573431992534;5688.857778555486;5719.313682358061;4244.108737165168;4329.15581461612;4352.39066530686;4362.345648152739;4363.454568178978;3882.9223415532097;3916.7649941003633;3922.2743792398496;3928.5678575356687;3984.242993831163;5426.213199086111;5465.371482279589;5466.453354664502;5469.890602187934;5485.533729632946;5539.335279766454;5817.214676018768;5819.301683797971;5820.534357251409;5831.096180092092;5456.399796022434;5548.334199896039;5572.3870374258795;5584.664920104807;5622.803201887914;4987.700737955734;5002.849914502571;5005.649604527721;5008.549230569266;5057.949420505822;5784.479396854304;6093.634381937098;6105;6106.603070800384;6106.694665266719;5759.337676167127;5856.765729370948;5863.17915491823;5876.324222714443;5930.822075337746;6019.6990150493175;6053.667048312385;6055.727492262947;6059.454649081604;6063.696815159136;5555.777768889199;5689.829305120853;5719.0277652798295;5750.827475175752;5754.3670196277535;5653;5675.148727690879;5678.68767217807;5696.1455781633085;5780.104083867007;5566.053770859045;5576.776928922797;5580.581456390868;5581.107022876483;5581.609287350009;5470.945290547203;5533.861653458534;5537.086380747131;5542.251796007487;5543.8891222174525;5634.971825141012;5649.293838270216;5679.858003549944;5699.059655156852;5702.287214098238;5729.1119876419225;5732.34078081026;5772.393898640582;5781.364049954417;5795.043817770021;5381.865453363697;5545.223668686306;5635.520980716685;5659.688717120598;5666.433356664301 12:00:01 INFO - PROCESS | 3417 | |1;ext.html;548.4612614609013;572.1132245020219;593.2258402784365;601.5909181756406;618.3877960818791;37423.625763742355;40925;40947.59052409475;41058.58941410585;41168.38247426287;40645.390319145234;40976.18047639045;41095.794521027354;41105.58894411055;41124.17751644965;8613.655453781841;8838.072002439747;8870.42342247755;8904.554772261394;8928.955355223216;8657.740267791976;8660.047394786568;8737.519436430994;8755.3433492488;8769.25461335784;8755.912440875605;8790.6923257686;8839.690610828622;8846.336524760636;8882.067382924797;8766.430182038148;8791.208791208823;8792.824143517093;8811.471311721285;8824.691135810215;8737.650493980233;8772.385932984693;8801.647934082694;8859.246964008067;8871.822563548758;39483.60516394857;39906.40140397896;40212;40278.59721402778;40324.596754032376;3317.0799047473356;3447.3450044491465;3481.9303613927577;3506.4740288956605;3536.6286539913453;31359;31364.686353136403;31551.684483155102;33250;33338.499922501185;4125.552484809782;4206.254310195147;4290.935635965463;4314.964408541959;4337.609615134653;341212;344877;344884;345276;346338;56056.35633683798;56104.15843762347;56677.43322566804;56920;57070.42929570734;37437.25125497475;38168.23663526714;38296.808515957244;58919.70540147358;58972.41027589669;15578.9221053894;15613.14127722986;15773.211339432983;15774.921125394529;15806.446774362843;10893.346399216072;11073.723156921142;11151.442427878736;11151.553937842395;11151.776964460665;18221.45335639933;18330.63338733218;18331;18470.81529184718;18652.34716784906;7183.281671832775;7276;7432.368248698921;7471.442420123829;7476.813079672943;869.5261082709939;953.3719835488798;999.91000809926;1011.8178727828914;1021.5862575656871;29888.55167172494;29916;30828;31182.84408577988;32174.35651286961;1016.4460369098858;1034.2966782587762;1046.3460337289193;1115.1747706697147;1124.5445594534226;15747.921260393854;16105;16224.594385140466;16391.09848958295;16787.832121678628;160327;161100;162185;162331;162928;56434;56790.716046419504;56824.14763778546;57168;57455;1300.7593595184921;1304.0415294758534;1309.430397776951;1340.189185542752;1350.6285771412743;29249.122526324245;30679;30851.382972340878;31114;31491.212719681276;50268.74865625795;50357.24464133114;50567.74716126396;50649.74675126601;50663.24005139852;416007;417053;419778;421816;421946;27768;28382.290442739097;28393;28664.713352866205;29901.10296691103;44802.77598611986;44850.775746121064;46185.538144619466;46459.303110452696;46575.53424465848;39191.60808391879;39601.40597890977;39749.60250397459;41083.7945810281;41330;38067.238655227295;40032.599674002886;40366.79816600898;41647;41748.40681623013;34647.13382165365;38640;38991;39157.41263881101;39459;34374.65625343715;34710.479342809376;37326;38280;38728.41907371448;26721.33196670099;27454.725452745217;27486.725132748415;27580.187650010655;27691 12:00:01 INFO - PROCESS | 3417 | |2;jquery.html;391.74145064257596;398.3685857915202;400.25552472401336;402.2457891453525;417.49483125418243;13408.26254555999;15142.772858407132;17968.73046904296;18495.982720950342;18540.351087711915;15185.620359491018;18604.720929186038;18734.25062997482;19404.223831046776;19636.607267854633;5597.692126933007;5657.377688454267;5693;5813.215215945836;5814.651120932736;5674.659520428788;5757.596968212227;5771.711414429283;5771.769129234825;5779.682117483558;5515.558755299567;5636.2954630671165;5704.714764261791;5749.108888122348;5750.6262092963825;5624.91562626561;5662.49037586615;5667.744951477193;5673.716314184295;5682.289713785777;5049.6212784041345;5060.544550990428;5097.898042039138;5389.946100538984;5427.158790387496;14137.717245655029;14379.640508987255;14432.134071955716;18895.43313700591;22440.66339004916;2204.7354317482004;2269.6368581027123;2446.13162327373;2459.0655550890547;2561.5901455767175;9951.104400603981;10062.195024398105;10248.333858299262;10791.838122428091;11032.28290161137;1910.6274276516085;1918.1368384227014;1941.9902900485406;1984.6229216448828;1986.384220891514;67617;69316.6534167331;69485;71452.6427367865;76680.61659691666;10356.326838755456;10831.566737330577;11136.944315278372;11314.434278286053;11320.886791131983;15366.308516116802;15483.380664773507;15577.143257120968;15688.76466852998;15702.607434814221;7596.126445458733;7881.211878812073;7920.247576480225;8047.396445266629;8222.671093156207;7331.74338898136;7338.522996005243;7380.667869945865;7610.8097297568;7713.267239612228;4414.205443020287;4426.623736982393;4453.4433195850515;4566.315052742115;4750;1956.7162761399802;2042.6323261813016;2044.8159665630164;2045.1103769860158;2058.8147066764063;837.0875745437502;871.4422769427572;940.5673390240429;992.3946392700446;1011.5397494140149;18083.909580452015;18203.27186912509;18721.812781872006;19076.33232836844;20553.794462055488;839.6573559768178;858.4420126917554;925.3707478914403;959.9376040557481;971.4754032822196;9880.407175569346;9961;10455.94772026135;10475.47622618866;10600.416977066336;162451;163964;163999;164039;229963;54584.454155458734;58593;89385.55307223422;90986;94390;1030.314840630987;1051.0435503691604;1056.028453822485;1057.9576816927238;1063.984040239397;17208.655826883143;17304.567385815455;17655.205515751564;17767.555811104827;17919.46241612754;41194.58805412027;41567.96080098022;42292.577074230096;43211.13577728491;43329.13341733211;60850.695746520985;61104;61161.69419152876;61893.69053154706;62382;8186.345092392713;8351.081381048201;8604.139586041596;8643.91356086431;8861.113888611088;12275.447604857982;12769.744605108031;12790.74418511606;12853;12860.742785144432;10495.160387168855;10771.730706732395;10846.945765271123;10933.453327333442;11539.8269025963;10785.40680262593;11026.614068507564;11052.889471105507;11214.327140371604;11348.375839328915;10940.56237750481;11267.267627604508;11482.138839586898;11493.333466647457;11505.827412588986;7508.624568771649;7627.351675107678;7859.724909628136;8066.516009039477;8629.784255393413;10206.489675516046;10674.306170098918;10726.195535335037;10799.946000269949;11108.666739997812 12:00:01 INFO - PROCESS | 3417 | |3;mootools.html;1470.2134358118406;1517.8861585381096;1646.2098192867422;1696.0756387768665;1769.548765064909;7227.096612923385;7858.332041776449;8070.273675369215;8504.744857654265;8517.36119791015;8092.878606820902;8316;8394.24451799338;8398.790030249247;8412.663493460253;2260.333201705501;2265.9773402265973;2280.384296240014;2292.5071109711407;2303.0787684925995;2247.3033359658475;2262.6945362376114;2337.614293641547;2341.929742107731;2346.061575369857;2282.897269622871;2288.187693368855;2303.389601755536;2314.3982564533258;2337.1936681844822;2274.3859158027403;2278.396225000376;2292.5185711000627;2305.5388922215457;2310.7111611048535;2223.1663126327626;2229.498362868358;2234.6201145805253;2239.6752470891793;2242.1031587365023;8354.665813367457;8364.623591938378;8516.616752246164;8520.488770673717;8545.658173673046;4710.434747830248;4816.229403295491;4826.638002149818;4834.3473631059705;4837.346958160639;3198.1524895902603;3211.855466504013;3363.209645733251;3373.1398493384277;3383.712384447325;1090.2422816142785;1118.8601424821898;1133.3879704959395;1149.3793351590132;1153.8384626152344;10924.672259832218;10951.014408703175;10957.780844383067;10964.945175274152;10996.945015274952;4061.6953728469894;4130.235906357273;4284.592963668447;4297.5702429756775;4338.848140315074;9429.62281508732;9432.056794320513;9437.103475169848;9458.054194580487;9470;4850.466448690641;4858.684185527929;4861.149298872683;4861.440934292602;4874.122657921608;3796.1458671798623;4390.912181756411;4482.058767658828;4497.168023915586;4497.280435130363;3737.7383583149463;3816.2749077675153;3836;3853.537575490959;3951.5455722591696;1273.5733529267613;1291.367230057284;1292.8901043411415;1293.1012946002627;1329.5147271245926;847.8473874702613;947.8720372749729;968.5109019944882;974.9512524373895;987.9527700637348;5614.354349249807;5658.122990936411;5678.545716342683;5834.795782147605;5874.471297583238;432.19827220506136;436.7314101827353;444.60430217106153;453.2792859353643;454.1983399300238;4075.5313138988804;4148.751074935513;4154.813033413504;4160.646345060643;4197.8320867165585;9954.552045157985;10389.792204155874;10440.164786817037;10440.63457778974;10440.791184176274;10130.44282564466;10311.07200351972;10349.844752328721;10355.430451325099;10361.222908281909;7710.267524585268;7713.961430192813;7764.184760600168;7832.177621349676;7834.451588388872;5742.483176514133;5842.415758424124;5858.94141058584;5932.555058370725;5969.462748352669;9580.808383832424;9636.662716804878;9666.420014799134;9779.119879210904;9784.80430391374;9587.568559414703;9914.40513569188;9942.453165075991;9994.650187243411;9995;6605.438537724155;6986.895196571953;7107.82230444243;7283.817904552428;7449.776506704808;7994.880076798969;8062.919370806451;8064.798380040546;8066;8091.433599647969;7052.365287124184;7102.680379382837;7149.106361704787;7291.41668666516;7349.154847192427;7089;7197.49617526789;7239.529430586995;7246.6376681166785;7248;6480.902786458301;6679.398854103154;6744.865102698017;6789;6831.69257383409;4989.301497790385;5088.923666144937;5144.536991670768;5287.656302340336;5341.839744807662;5078.7206703631655;5084.8220312288895;5086.3896332440345;5157.819476318311;5192.27308176848 12:00:01 INFO - PROCESS | 3417 | |4;prototype.html;317.93967119655946;326.2056891469272;330.83127604921486;335.13033677606603;336.40120585358056;5339.652922560031;5426;5527.397054854093;5556.583256255777;5583;5436.23322420214;5467;5492.375032478555;5509.669419834802;5510.8071217507395;4376.343548467724;4383.408239887623;4390;4391.780410979454;4399.604035636792;4182.64447521961;4301.139772045603;4357.651387888977;4393.516713161565;4410.228210063242;4275.636570891463;4287.078278170193;4297.914041719164;4298.333758267474;4298.591633794785;4297.957020429787;4304.139172165548;4310.612044915957;4371.562843715603;4393.472783265996;3537.6816086552076;3878.2825177342283;3880.204558065618;3885.3783394657003;3892.2020985697864;5357.303550538405;5379.354477462691;5399.5680345572655;5408.91886621701;5414.6480478769145;4885.169521181408;4886;4888.022395520875;4894.706317620954;4938.925916111261;5570.61005729595;5720.828375148711;5730;5734.025215713339;5755.712214389264;4063.3295506241434;4069.6540794032544;4074.5721699221453;4098.73358231717;4104.220198162369;5962.34414214436;6004.919114559378;6030.427109424598;6046.667433291167;6066.939330606726;4071.1654110907193;4210.389493523422;4212.452381190487;4226.281532139544;4266.765327906933;4387.627051700578;4397.472303323621;4402.185595664812;4402.273624851863;4418.668599855024;4903.828366007173;4965;4973.602111831045;4983.277424773388;5025.547700706954;5543.750531226105;5807.390224026501;5807.94192058074;5836.9124463133085;5858;1499.5951093204992;1504.8043754311868;1505.7063872544747;1507.8718308943862;1522.8096487939008;947.5404428852002;976.5995941663883;979.9902000979899;993.7664648807524;1006.1095930101912;4909.926351104737;4920.803167873317;4930.827421040246;4947.455779864212;4968.453470118284;5092.796288148433;5196.740162991835;5203.2195170723935;5207.3490813648295;5210.593139852294;4627.514111018362;4852.126617208936;4868.659193856396;4953.23224900141;5005.9749701251985;2744.931376715558;2748.7526122649056;2758.813710104674;2762.958555621667;2797.202797202787;5280.524752772192;5388.568914486832;5449.373322068013;5458.9454105458435;5462.890742185214;5312.335958005249;5341.732913354317;5643.266375371258;6067.302260240041;6078.939210607926;6092.4107254416695;6100.267967843798;6105.9694701526205;6138.785142519991;6199.721012554446;5649.887002260014;5965.28416590012;5970.76116955317;5975.087971848967;6035.1249068885645;5878.148383259259;5891.317926296065;5897.616654917417;5907.793227237026;5910.645361278337;6182.289036760651;6182.412670796267;6267.4045965633195;6270.623762574261;6284.183056202664;4037.596240375939;4079.306517891906;4151.335786274181;4192.350185721218;4192.8532501363525;5887.8233652990475;5900.527957763283;5909;5930.851728706644;5956.315023772322;5684.289463817023;5701.515371193495;5812.18629391894;5823.970880145572;5826.242588463472;5691.26013618227;5693.430656934273;5694.886102278014;5720.683123335056;5761.395053519488;5737.512311453574;5748.137779333133;5764.365919748908;5765.682887441231;5795.33353664334;5679.971600141973;5772.105323674838;5794.739236734273;5813.82558523245;5817.360090390139;5640.633358831663;5671.071835575924;5672.290963629546;5682.232898558807;5697.857553561194 12:00:01 INFO - PROCESS | 3417 | |5;yui.html;670.2794495916891;720.3732752505321;743.3421422041495;763.6334559411482;845.9196376344245;13800.378982945766;14707;14713.411463541459;14747.705045899102;14994.925025374872;14824.925875370634;14963.177025263607;14989.77515337268;15058.548243552683;15113.168775717331;784.5332027443676;787.0830482487895;791.7308115240817;811.7321283976303;820.2535692519808;806.246159840548;808.4340961327065;808.8988876390451;811.2414892075899;812.0661239574507;857.1043259793499;858.4720396955889;859.188067276424;859.7119964811795;861.4056301152185;841.474078700809;842.3303473738392;843.359047124187;847.8770578266148;848.8811566380712;619.0899377914459;619.9318075011745;620.057512580879;623.0809555905004;624.3506752976898;12768.233905965579;12779.936100319532;12795.552155674506;12820.166689165175;12830.177360980662;14074.788878166733;14574.344154512966;14744.705105897821;14843;14864.925675371662;11925.403729813475;12078.637640870787;12134.514619415213;12231.633051008395;12811.743765124738;3668.137987572918;3747.700183985302;3771.302309072803;3779.130799916035;3882.941755873636;79426;81901.59049204775;81954.59022704848;82640.58679706624;83388;11270.492827822767;11315.83026254607;11402.543898243977;11446;11567.305961642329;21868.89065554662;21914;21927.451813704785;21927.67108493374;21928.232511862007;8105.55419451924;8106.351491880635;8237.629306681094;8551.187637174458;8705.260052895575;4739.336492890998;4773.212419950739;4790.616750659939;4892.755362231874;4933.50664933511;3322.2857085726687;3402.5576675032585;3428.879989200416;3433.9313213735586;3442.6729460701195;537.5833728860086;575.323994306688;577.0680351232812;592.7184587320988;594.3402822866615;589.5961266532439;606.5935822998601;619.0899377914459;621.2203684376079;633.4457349818908;8820.294376449869;9206.769830754285;9208.171264586219;9634.855477167848;9643.662471813454;606.7421345927963;631.2488139114439;652.2890049845691;683.2927919603187;688.3082502085472;4268.274393353137;4479.664025198123;4547.3406356078185;4577.542245775396;4595.931061034087;120036.3998180021;123648;124049.37975310066;124854;127471.36264318804;86175.56912215524;103872;104724.47637761915;106908;107486.46256768666;88039.55980220057;89473;91802.4290206668;93767.53116234374;94622.52688736512;8177.05963814169;8455.239028487465;8580.227779499875;8703.173198546128;8744.213020827901;52151.73924130355;52300.73849630728;52681.209781852536;52903.470965291395;53344.1998370017;72348.27651723416;78577.60711196407;78789.60605196937;80394.59802701183;80622.59688701518;11670.824937626112;11676.591319304123;11732.530698771954;11796.643878185208;12229.93885030569;12285.815712764494;12620.55828046014;13273.336333183495;13394;13927.373268202753;13460.93269533646;14183.069647676266;14296.785548216578;14624.70750584961;14885.181315027778;12909.419076141408;13537.323133843465;13548.661283467993;13674.93162534181;13849.584512464642;13839.377228024561;14071.507497237548;14365.569032929028;14454.494092706705;14922.104673719612;10092.34399764013;10426.374417534973;10506.632267870587;10720.62477813304;10868.184886133413;10751.731206719582;11153.275037122561;12167.87832121703;12351.444185011876;12415.130940834055 12:00:01 INFO - PROCESS | 3417 | __end_tp_report 12:00:01 INFO - PROCESS | 3417 | __start_cc_report 12:00:01 INFO - PROCESS | 3417 | _x_x_mozilla_cycle_collect,316 12:00:01 INFO - PROCESS | 3417 | __end_cc_report 12:00:01 INFO - PROCESS | 3417 | __startTimestamp1472583601509__endTimestamp 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | ------- Summary: start ------- 12:00:01 INFO - PROCESS | 3417 | Number of tests: 6 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | [#0] dojo.html Cycles:165 Average:5368.90 Median:5566.05 stddev:623.71 (11.2%) stddev-sans-first:597.48 12:00:01 INFO - PROCESS | 3417 | Values: 3007.2 3028.8 3049.2 3063.2 3064.1 5287.1 5476.2 5502.4 5521.3 5536.9 5466.5 5498.4 5533.8 5562.2 5572.6 4914.6 5004.6 5017.2 5054.3 5094.3 5025.9 5039.8 5051.3 5100.4 5103.1 4620.6 4885.6 4951.2 4955.7 4987.7 4829.3 4835.9 4846.5 4940.6 5031.5 4812.1 4864.5 4866.6 4881.0 4899.9 5290.6 5332.8 5388.5 5407.6 5443.8 5808.4 5831.5 5838.1 5841.8 5873.7 5821.1 5844.5 5859.2 5873.7 5881.8 5186.7 5342.4 5353.8 5399.8 5480.1 5779.1 5852.9 5892.1 5893.1 5912.1 5578.6 5581.3 5585.1 5634.2 5646.3 5490.2 5695.1 5703.1 5775.4 5793.9 5546.2 5634.1 5656.8 5666.7 5682.9 5667.1 5681.7 5687.6 5688.9 5719.3 4244.1 4329.2 4352.4 4362.3 4363.5 3882.9 3916.8 3922.3 3928.6 3984.2 5426.2 5465.4 5466.5 5469.9 5485.5 5539.3 5817.2 5819.3 5820.5 5831.1 5456.4 5548.3 5572.4 5584.7 5622.8 4987.7 5002.8 5005.6 5008.5 5057.9 5784.5 6093.6 6105.0 6106.6 6106.7 5759.3 5856.8 5863.2 5876.3 5930.8 6019.7 6053.7 6055.7 6059.5 6063.7 5555.8 5689.8 5719.0 5750.8 5754.4 5653.0 5675.1 5678.7 5696.1 5780.1 5566.1 5576.8 5580.6 5581.1 5581.6 5470.9 5533.9 5537.1 5542.3 5543.9 5635.0 5649.3 5679.9 5699.1 5702.3 5729.1 5732.3 5772.4 5781.4 5795.0 5381.9 5545.2 5635.5 5659.7 5666.4 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | [#1] ext.html Cycles:180 Average:48128.17 Median:39828.00 stddev:86452.36 (217.1%) stddev-sans-first:86621.07 12:00:01 INFO - PROCESS | 3417 | Values: 548.5 572.1 593.2 601.6 618.4 37423.6 40925.0 40947.6 41058.6 41168.4 40645.4 40976.2 41095.8 41105.6 41124.2 8613.7 8838.1 8870.4 8904.6 8929.0 8657.7 8660.0 8737.5 8755.3 8769.3 8755.9 8790.7 8839.7 8846.3 8882.1 8766.4 8791.2 8792.8 8811.5 8824.7 8737.7 8772.4 8801.6 8859.2 8871.8 39483.6 39906.4 40212.0 40278.6 40324.6 3317.1 3447.3 3481.9 3506.5 3536.6 31359.0 31364.7 31551.7 33250.0 33338.5 4125.6 4206.3 4290.9 4315.0 4337.6 341212.0 344877.0 344884.0 345276.0 346338.0 56056.4 56104.2 56677.4 56920.0 57070.4 37437.3 38168.2 38296.8 58919.7 58972.4 15578.9 15613.1 15773.2 15774.9 15806.4 10893.3 11073.7 11151.4 11151.6 11151.8 18221.5 18330.6 18331.0 18470.8 18652.3 7183.3 7276.0 7432.4 7471.4 7476.8 869.5 953.4 999.9 1011.8 1021.6 29888.6 29916.0 30828.0 31182.8 32174.4 1016.4 1034.3 1046.3 1115.2 1124.5 15747.9 16105.0 16224.6 16391.1 16787.8 160327.0 161100.0 162185.0 162331.0 162928.0 56434.0 56790.7 56824.1 57168.0 57455.0 1300.8 1304.0 1309.4 1340.2 1350.6 29249.1 30679.0 30851.4 31114.0 31491.2 50268.7 50357.2 50567.7 50649.7 50663.2 416007.0 417053.0 419778.0 421816.0 421946.0 27768.0 28382.3 28393.0 28664.7 29901.1 44802.8 44850.8 46185.5 46459.3 46575.5 39191.6 39601.4 39749.6 41083.8 41330.0 38067.2 40032.6 40366.8 41647.0 41748.4 34647.1 38640.0 38991.0 39157.4 39459.0 34374.7 34710.5 37326.0 38280.0 38728.4 26721.3 27454.7 27486.7 27580.2 27691.0 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | [#2] jquery.html Cycles:180 Average:19322.93 Median:2452.60 stddev:32894.25 (1341.2%) stddev-sans-first:32955.81 12:00:01 INFO - PROCESS | 3417 | Values: 391.7 398.4 400.3 402.2 417.5 13408.3 15142.8 17968.7 18496.0 18540.4 15185.6 18604.7 18734.3 19404.2 19636.6 5597.7 5657.4 5693.0 5813.2 5814.7 5674.7 5757.6 5771.7 5771.8 5779.7 5515.6 5636.3 5704.7 5749.1 5750.6 5624.9 5662.5 5667.7 5673.7 5682.3 5049.6 5060.5 5097.9 5389.9 5427.2 14137.7 14379.6 14432.1 18895.4 22440.7 2204.7 2269.6 2446.1 2459.1 2561.6 9951.1 10062.2 10248.3 10791.8 11032.3 1910.6 1918.1 1942.0 1984.6 1986.4 67617.0 69316.7 69485.0 71452.6 76680.6 10356.3 10831.6 11136.9 11314.4 11320.9 15366.3 15483.4 15577.1 15688.8 15702.6 7596.1 7881.2 7920.2 8047.4 8222.7 7331.7 7338.5 7380.7 7610.8 7713.3 4414.2 4426.6 4453.4 4566.3 4750.0 1956.7 2042.6 2044.8 2045.1 2058.8 837.1 871.4 940.6 992.4 1011.5 18083.9 18203.3 18721.8 19076.3 20553.8 839.7 858.4 925.4 959.9 971.5 9880.4 9961.0 10455.9 10475.5 10600.4 162451.0 163964.0 163999.0 164039.0 229963.0 54584.5 58593.0 89385.6 90986.0 94390.0 1030.3 1051.0 1056.0 1058.0 1064.0 17208.7 17304.6 17655.2 17767.6 17919.5 41194.6 41568.0 42292.6 43211.1 43329.1 60850.7 61104.0 61161.7 61893.7 62382.0 8186.3 8351.1 8604.1 8643.9 8861.1 12275.4 12769.7 12790.7 12853.0 12860.7 10495.2 10771.7 10846.9 10933.5 11539.8 10785.4 11026.6 11052.9 11214.3 11348.4 10940.6 11267.3 11482.1 11493.3 11505.8 7508.6 7627.4 7859.7 8066.5 8629.8 10206.5 10674.3 10726.2 10799.9 11108.7 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | [#3] mootools.html Cycles:180 Average:5491.83 Median:4859.92 stddev:3069.69 (63.2%) stddev-sans-first:3063.42 12:00:01 INFO - PROCESS | 3417 | Values: 1470.2 1517.9 1646.2 1696.1 1769.5 7227.1 7858.3 8070.3 8504.7 8517.4 8092.9 8316.0 8394.2 8398.8 8412.7 2260.3 2266.0 2280.4 2292.5 2303.1 2247.3 2262.7 2337.6 2341.9 2346.1 2282.9 2288.2 2303.4 2314.4 2337.2 2274.4 2278.4 2292.5 2305.5 2310.7 2223.2 2229.5 2234.6 2239.7 2242.1 8354.7 8364.6 8516.6 8520.5 8545.7 4710.4 4816.2 4826.6 4834.3 4837.3 3198.2 3211.9 3363.2 3373.1 3383.7 1090.2 1118.9 1133.4 1149.4 1153.8 10924.7 10951.0 10957.8 10964.9 10996.9 4061.7 4130.2 4284.6 4297.6 4338.8 9429.6 9432.1 9437.1 9458.1 9470.0 4850.5 4858.7 4861.1 4861.4 4874.1 3796.1 4390.9 4482.1 4497.2 4497.3 3737.7 3816.3 3836.0 3853.5 3951.5 1273.6 1291.4 1292.9 1293.1 1329.5 847.8 947.9 968.5 975.0 988.0 5614.4 5658.1 5678.5 5834.8 5874.5 432.2 436.7 444.6 453.3 454.2 4075.5 4148.8 4154.8 4160.6 4197.8 9954.6 10389.8 10440.2 10440.6 10440.8 10130.4 10311.1 10349.8 10355.4 10361.2 7710.3 7714.0 7764.2 7832.2 7834.5 5742.5 5842.4 5858.9 5932.6 5969.5 9580.8 9636.7 9666.4 9779.1 9784.8 9587.6 9914.4 9942.5 9994.7 9995.0 6605.4 6986.9 7107.8 7283.8 7449.8 7994.9 8062.9 8064.8 8066.0 8091.4 7052.4 7102.7 7149.1 7291.4 7349.2 7089.0 7197.5 7239.5 7246.6 7248.0 6480.9 6679.4 6744.9 6789.0 6831.7 4989.3 5088.9 5144.5 5287.7 5341.8 5078.7 5084.8 5086.4 5157.8 5192.3 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | [#4] prototype.html Cycles:180 Average:4781.78 Median:5368.33 stddev:1407.82 (26.2%) stddev-sans-first:1371.33 12:00:01 INFO - PROCESS | 3417 | Values: 317.9 326.2 330.8 335.1 336.4 5339.7 5426.0 5527.4 5556.6 5583.0 5436.2 5467.0 5492.4 5509.7 5510.8 4376.3 4383.4 4390.0 4391.8 4399.6 4182.6 4301.1 4357.7 4393.5 4410.2 4275.6 4287.1 4297.9 4298.3 4298.6 4298.0 4304.1 4310.6 4371.6 4393.5 3537.7 3878.3 3880.2 3885.4 3892.2 5357.3 5379.4 5399.6 5408.9 5414.6 4885.2 4886.0 4888.0 4894.7 4938.9 5570.6 5720.8 5730.0 5734.0 5755.7 4063.3 4069.7 4074.6 4098.7 4104.2 5962.3 6004.9 6030.4 6046.7 6066.9 4071.2 4210.4 4212.5 4226.3 4266.8 4387.6 4397.5 4402.2 4402.3 4418.7 4903.8 4965.0 4973.6 4983.3 5025.5 5543.8 5807.4 5807.9 5836.9 5858.0 1499.6 1504.8 1505.7 1507.9 1522.8 947.5 976.6 980.0 993.8 1006.1 4909.9 4920.8 4930.8 4947.5 4968.5 5092.8 5196.7 5203.2 5207.3 5210.6 4627.5 4852.1 4868.7 4953.2 5006.0 2744.9 2748.8 2758.8 2763.0 2797.2 5280.5 5388.6 5449.4 5458.9 5462.9 5312.3 5341.7 5643.3 6067.3 6078.9 6092.4 6100.3 6106.0 6138.8 6199.7 5649.9 5965.3 5970.8 5975.1 6035.1 5878.1 5891.3 5897.6 5907.8 5910.6 6182.3 6182.4 6267.4 6270.6 6284.2 4037.6 4079.3 4151.3 4192.4 4192.9 5887.8 5900.5 5909.0 5930.9 5956.3 5684.3 5701.5 5812.2 5824.0 5826.2 5691.3 5693.4 5694.9 5720.7 5761.4 5737.5 5748.1 5764.4 5765.7 5795.3 5680.0 5772.1 5794.7 5813.8 5817.4 5640.6 5671.1 5672.3 5682.2 5697.9 12:00:01 INFO - PROCESS | 3417 | 12:00:01 INFO - PROCESS | 3417 | [#5] yui.html Cycles:180 Average:21420.99 Median:4513.50 stddev:31847.91 (705.6%) stddev-sans-first:31899.14 12:00:01 INFO - PROCESS | 3417 | Values: 670.3 720.4 743.3 763.6 845.9 13800.4 14707.0 14713.4 14747.7 14994.9 14824.9 14963.2 14989.8 15058.5 15113.2 784.5 787.1 791.7 811.7 820.3 806.2 808.4 808.9 811.2 812.1 857.1 858.5 859.2 859.7 861.4 841.5 842.3 843.4 847.9 848.9 619.1 619.9 620.1 623.1 624.4 12768.2 12779.9 12795.6 12820.2 12830.2 14074.8 14574.3 14744.7 14843.0 14864.9 11925.4 12078.6 12134.5 12231.6 12811.7 3668.1 3747.7 3771.3 3779.1 3882.9 79426.0 81901.6 81954.6 82640.6 83388.0 11270.5 11315.8 11402.5 11446.0 11567.3 21868.9 21914.0 21927.5 21927.7 21928.2 8105.6 8106.4 8237.6 8551.2 8705.3 4739.3 4773.2 4790.6 4892.8 4933.5 3322.3 3402.6 3428.9 3433.9 3442.7 537.6 575.3 577.1 592.7 594.3 589.6 606.6 619.1 621.2 633.4 8820.3 9206.8 9208.2 9634.9 9643.7 606.7 631.2 652.3 683.3 688.3 4268.3 4479.7 4547.3 4577.5 4595.9 120036.4 123648.0 124049.4 124854.0 127471.4 86175.6 103872.0 104724.5 106908.0 107486.5 88039.6 89473.0 91802.4 93767.5 94622.5 8177.1 8455.2 8580.2 8703.2 8744.2 52151.7 52300.7 52681.2 52903.5 53344.2 72348.3 78577.6 78789.6 80394.6 80622.6 11670.8 11676.6 11732.5 11796.6 12229.9 12285.8 12620.6 13273.3 13394.0 13927.4 13460.9 14183.1 14296.8 14624.7 14885.2 12909.4 13537.3 13548.7 13674.9 13849.6 13839.4 14071.5 14365.6 14454.5 14922.1 10092.3 10426.4 10506.6 10720.6 10868.2 10751.7 11153.3 12167.9 12351.4 12415.1 12:00:01 INFO - PROCESS | 3417 | -------- Summary: end -------- 12:00:01 INFO - PROCESS | 3417 | 12:00:02 INFO - TEST-INFO | 3417: exit 0 12:00:02 INFO - TEST-OK | dromaeo_css | took 1116274ms 12:00:02 INFO - TEST-START | kraken 12:00:02 INFO - operating with platform_type : linux_ 12:00:02 INFO - Initialising browser for kraken test... 12:00:02 INFO - TEST-INFO | started process 3771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEmgde/profile http://localhost:50531/getInfo.html) 12:00:07 INFO - PROCESS | 3771 | __metrics Screen width/height:1600/1200 12:00:07 INFO - PROCESS | 3771 | colorDepth:24 12:00:07 INFO - PROCESS | 3771 | Browser inner width/height: 1024/697 12:00:07 INFO - PROCESS | 3771 | __metrics 12:00:07 ERROR - PROCESS | 3771 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 12:00:08 INFO - TEST-INFO | 3771: exit 0 12:00:08 INFO - Browser initialized. 12:00:08 INFO - Running cycle 1/1 for kraken test... 12:00:08 INFO - TEST-INFO | started process 3893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEmgde/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:20 INFO - PROCESS | 3893 | RSS: Main: 191512576 12:00:20 INFO - PROCESS | 3893 | 12:00:23 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50531/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:24 INFO - PROCESS | 3893 | RSS: Main: 204599296 12:00:24 INFO - PROCESS | 3893 | 12:00:27 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50531/tests/kraken/driver.html?testName=audio-dft) 12:00:27 INFO - PROCESS | 3893 | RSS: Main: 203792384 12:00:27 INFO - PROCESS | 3893 | 12:00:30 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50531/tests/kraken/driver.html?testName=audio-fft) 12:00:31 INFO - PROCESS | 3893 | RSS: Main: 195604480 12:00:31 INFO - PROCESS | 3893 | 12:00:33 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50531/tests/kraken/driver.html?testName=audio-oscillator) 12:00:33 INFO - PROCESS | 3893 | RSS: Main: 196730880 12:00:33 INFO - PROCESS | 3893 | 12:00:36 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:00:36 INFO - PROCESS | 3893 | RSS: Main: 196489216 12:00:36 INFO - PROCESS | 3893 | 12:00:39 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50531/tests/kraken/driver.html?testName=imaging-darkroom) 12:00:40 INFO - PROCESS | 3893 | RSS: Main: 196927488 12:00:40 INFO - PROCESS | 3893 | 12:00:43 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50531/tests/kraken/driver.html?testName=imaging-desaturate) 12:00:44 INFO - PROCESS | 3893 | RSS: Main: 194981888 12:00:44 INFO - PROCESS | 3893 | 12:00:47 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50531/tests/kraken/driver.html?testName=json-parse-financial) 12:00:48 INFO - PROCESS | 3893 | RSS: Main: 196268032 12:00:48 INFO - PROCESS | 3893 | 12:00:49 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:00:50 INFO - PROCESS | 3893 | RSS: Main: 196374528 12:00:50 INFO - PROCESS | 3893 | 12:00:52 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:52 INFO - PROCESS | 3893 | RSS: Main: 196358144 12:00:52 INFO - PROCESS | 3893 | 12:00:54 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:55 INFO - PROCESS | 3893 | RSS: Main: 197054464 12:00:55 INFO - PROCESS | 3893 | 12:00:58 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:58 INFO - PROCESS | 3893 | RSS: Main: 196927488 12:00:58 INFO - PROCESS | 3893 | 12:01:01 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:01:02 INFO - PROCESS | 3893 | RSS: Main: 197287936 12:01:02 INFO - PROCESS | 3893 | 12:01:03 INFO - PROCESS | 3893 | Cycle 1(1): loaded http://localhost:50531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50531/tests/kraken/driver.html?testName=ai-astar) 12:01:04 INFO - PROCESS | 3893 | RSS: Main: 199184384 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | __start_tp_report 12:01:04 INFO - PROCESS | 3893 | _x_x_mozilla_page_load 12:01:04 INFO - PROCESS | 3893 | _x_x_mozilla_page_load_details 12:01:04 INFO - PROCESS | 3893 | |i|pagename|runs| 12:01:04 INFO - PROCESS | 3893 | |0;ai-astar;107;113;113;114;113;112;113;114;113;131 12:01:04 INFO - PROCESS | 3893 | |1;audio-beat-detection;153;125;145;186;122;149;153;120;181;123 12:01:04 INFO - PROCESS | 3893 | |2;audio-dft;163;163;164;174;161;165;166;165;163;161 12:01:04 INFO - PROCESS | 3893 | |3;audio-fft;75;76;74;176;77;77;77;76;178;76 12:01:04 INFO - PROCESS | 3893 | |4;audio-oscillator;83;83;148;83;85;83;145;82;88;143 12:01:04 INFO - PROCESS | 3893 | |5;imaging-gaussian-blur;118;118;119;118;117;117;118;118;118;117 12:01:04 INFO - PROCESS | 3893 | |6;imaging-darkroom;148;147;147;147;146;148;147;147;147;147 12:01:04 INFO - PROCESS | 3893 | |7;imaging-desaturate;97;96;98;95;96;96;98;96;97;97 12:01:04 INFO - PROCESS | 3893 | |8;json-parse-financial;51;54;55;55;56;54;56;53;55;53 12:01:04 INFO - PROCESS | 3893 | |9;json-stringify-tinderbox;63;63;68;64;63;63;63;64;64;63 12:01:04 INFO - PROCESS | 3893 | |10;stanford-crypto-aes;80;80;80;86;86;81;80;80;78;80 12:01:04 INFO - PROCESS | 3893 | |11;stanford-crypto-ccm;126;125;141;128;133;151;132;138;183;128 12:01:04 INFO - PROCESS | 3893 | |12;stanford-crypto-pbkdf2;167;171;165;164;163;165;163;166;170;169 12:01:04 INFO - PROCESS | 3893 | |13;stanford-crypto-sha256-iterative;69;67;66;67;66;68;74;66;65;65 12:01:04 INFO - PROCESS | 3893 | __end_tp_report 12:01:04 INFO - PROCESS | 3893 | __start_cc_report 12:01:04 INFO - PROCESS | 3893 | _x_x_mozilla_cycle_collect,815 12:01:04 INFO - PROCESS | 3893 | __end_cc_report 12:01:04 INFO - PROCESS | 3893 | __startTimestamp1472583664246__endTimestamp 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | ------- Summary: start ------- 12:01:04 INFO - PROCESS | 3893 | Number of tests: 14 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#0] ai-astar Cycles:10 Average:114.30 Median:113.00 stddev:6.20 (5.5%) stddev-sans-first:5.99 12:01:04 INFO - PROCESS | 3893 | Values: 107.0 113.0 113.0 114.0 113.0 112.0 113.0 114.0 113.0 131.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:151.00 stddev:23.93 (15.8%) stddev-sans-first:25.24 12:01:04 INFO - PROCESS | 3893 | Values: 153.0 125.0 145.0 186.0 122.0 149.0 153.0 120.0 181.0 123.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:3.72 (2.3%) stddev-sans-first:3.91 12:01:04 INFO - PROCESS | 3893 | Values: 163.0 163.0 164.0 174.0 161.0 165.0 166.0 165.0 163.0 161.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#3] audio-fft Cycles:10 Average:96.20 Median:76.00 stddev:42.60 (56.1%) stddev-sans-first:44.49 12:01:04 INFO - PROCESS | 3893 | Values: 75.0 76.0 74.0 176.0 77.0 77.0 77.0 76.0 178.0 76.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:83.00 stddev:29.77 (35.9%) stddev-sans-first:30.74 12:01:04 INFO - PROCESS | 3893 | Values: 83.0 83.0 148.0 83.0 85.0 83.0 145.0 82.0 88.0 143.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 12:01:04 INFO - PROCESS | 3893 | Values: 118.0 118.0 119.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 12:01:04 INFO - PROCESS | 3893 | Values: 148.0 147.0 147.0 147.0 146.0 148.0 147.0 147.0 147.0 147.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 12:01:04 INFO - PROCESS | 3893 | Values: 97.0 96.0 98.0 95.0 96.0 96.0 98.0 96.0 97.0 97.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.55 (2.8%) stddev-sans-first:1.13 12:01:04 INFO - PROCESS | 3893 | Values: 51.0 54.0 55.0 55.0 56.0 54.0 56.0 53.0 55.0 53.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:63.50 stddev:1.55 (2.4%) stddev-sans-first:1.62 12:01:04 INFO - PROCESS | 3893 | Values: 63.0 63.0 68.0 64.0 63.0 63.0 63.0 64.0 64.0 63.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.00 stddev:2.69 (3.4%) stddev-sans-first:2.82 12:01:04 INFO - PROCESS | 3893 | Values: 80.0 80.0 80.0 86.0 86.0 81.0 80.0 80.0 78.0 80.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:135.50 stddev:17.56 (13.0%) stddev-sans-first:18.03 12:01:04 INFO - PROCESS | 3893 | Values: 126.0 125.0 141.0 128.0 133.0 151.0 132.0 138.0 183.0 128.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:2.87 (1.7%) stddev-sans-first:3.03 12:01:04 INFO - PROCESS | 3893 | Values: 167.0 171.0 165.0 164.0 163.0 165.0 163.0 166.0 170.0 169.0 12:01:04 INFO - PROCESS | 3893 | 12:01:04 INFO - PROCESS | 3893 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.67 (4.0%) stddev-sans-first:2.76 12:01:04 INFO - PROCESS | 3893 | Values: 69.0 67.0 66.0 67.0 66.0 68.0 74.0 66.0 65.0 65.0 12:01:04 INFO - PROCESS | 3893 | -------- Summary: end -------- 12:01:04 INFO - PROCESS | 3893 | 12:01:05 INFO - TEST-INFO | 3893: exit 0 12:01:05 INFO - TEST-OK | kraken | took 62910ms 12:01:05 INFO - SUITE-END | took 1179s 12:01:05 INFO - Completed test suite (00:19:39) 12:01:05 INFO - javascript benchmark 12:01:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7038.609628555524, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.248187953012, 3028.803127796693, 3049.1919641295062, 3063.1729433053074, 3064.1420402287367, 5287.074761916659, 5476.151196564534, 5502.394736578973, 5521.282233309669, 5536.889262214763, 5466.480684334992, 5498.367687715904, 5533.833984980447, 5562.16567514872, 5572.58205634577, 4914.582260507852, 5004.649674522785, 5017.247412888078, 5054.317667114948, 5094.337736094302, 5025.899482010358, 5039.790450291922, 5051.292819005343, 5100.413452452978, 5103.055934652083, 4620.561046700558, 4885.560299573055, 4951.23255895335, 4955.677880937764, 4987.650864439491, 4829.251466022772, 4835.903281934342, 4846.515348465161, 4940.580050695695, 5031.496850314976, 4812.109759694433, 4864.513548645143, 4866.562009419134, 4880.951190488086, 4899.902001959977, 5290.55030322423, 5332.760025798849, 5388.541973932221, 5407.567394608422, 5443.836684899459, 5808.4191580842, 5831.475167234969, 5838.095095260242, 5841.795537156179, 5873.706314684248, 5821.068629019336, 5844.47399734026, 5859.238299021143, 5873.676947767871, 5881.794137205177, 5186.72925133341, 5342.358916929955, 5353.785848566092, 5399.757010934517, 5480.123180291134, 5779.133130030529, 5852.8536786579825, 5892.057270836645, 5893.14549390336, 5912.113183022581, 5578.609497335147, 5581.330240371181, 5585.050541407971, 5634.239377684042, 5646.265985421869, 5490.203920431595, 5695.088785794253, 5703.058995265735, 5775.422457754275, 5793.8551536211935, 5546.168074788733, 5634.070378387521, 5656.773729050792, 5666.660000399989, 5682.914756278659, 5667.093265077568, 5681.659100453986, 5687.573431992534, 5688.857778555486, 5719.313682358061, 4244.108737165168, 4329.15581461612, 4352.39066530686, 4362.345648152739, 4363.454568178978, 3882.9223415532097, 3916.7649941003633, 3922.2743792398496, 3928.5678575356687, 3984.242993831163, 5426.213199086111, 5465.371482279589, 5466.453354664502, 5469.890602187934, 5485.533729632946, 5539.335279766454, 5817.214676018768, 5819.301683797971, 5820.534357251409, 5831.096180092092, 5456.399796022434, 5548.334199896039, 5572.3870374258795, 5584.664920104807, 5622.803201887914, 4987.700737955734, 5002.849914502571, 5005.649604527721, 5008.549230569266, 5057.949420505822, 5784.479396854304, 6093.634381937098, 6105.0, 6106.603070800384, 6106.694665266719, 5759.337676167127, 5856.765729370948, 5863.17915491823, 5876.324222714443, 5930.822075337746, 6019.6990150493175, 6053.667048312385, 6055.727492262947, 6059.454649081604, 6063.696815159136, 5555.777768889199, 5689.829305120853, 5719.0277652798295, 5750.827475175752, 5754.3670196277535, 5653.0, 5675.148727690879, 5678.68767217807, 5696.1455781633085, 5780.104083867007, 5566.053770859045, 5576.776928922797, 5580.581456390868, 5581.107022876483, 5581.609287350009, 5470.945290547203, 5533.861653458534, 5537.086380747131, 5542.251796007487, 5543.8891222174525, 5634.971825141012, 5649.293838270216, 5679.858003549944, 5699.059655156852, 5702.287214098238, 5729.1119876419225, 5732.34078081026, 5772.393898640582, 5781.364049954417, 5795.043817770021, 5381.865453363697, 5545.223668686306, 5635.520980716685, 5659.688717120598, 5666.433356664301], "value": 5325.32704624889, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.4612614609013, 572.1132245020219, 593.2258402784365, 601.5909181756406, 618.3877960818791, 37423.625763742355, 40925.0, 40947.59052409475, 41058.58941410585, 41168.38247426287, 40645.390319145234, 40976.18047639045, 41095.794521027354, 41105.58894411055, 41124.17751644965, 8613.655453781841, 8838.072002439747, 8870.42342247755, 8904.554772261394, 8928.955355223216, 8657.740267791976, 8660.047394786568, 8737.519436430994, 8755.3433492488, 8769.25461335784, 8755.912440875605, 8790.6923257686, 8839.690610828622, 8846.336524760636, 8882.067382924797, 8766.430182038148, 8791.208791208823, 8792.824143517093, 8811.471311721285, 8824.691135810215, 8737.650493980233, 8772.385932984693, 8801.647934082694, 8859.246964008067, 8871.822563548758, 39483.60516394857, 39906.40140397896, 40212.0, 40278.59721402778, 40324.596754032376, 3317.0799047473356, 3447.3450044491465, 3481.9303613927577, 3506.4740288956605, 3536.6286539913453, 31359.0, 31364.686353136403, 31551.684483155102, 33250.0, 33338.499922501185, 4125.552484809782, 4206.254310195147, 4290.935635965463, 4314.964408541959, 4337.609615134653, 341212.0, 344877.0, 344884.0, 345276.0, 346338.0, 56056.35633683798, 56104.15843762347, 56677.43322566804, 56920.0, 57070.42929570734, 37437.25125497475, 38168.23663526714, 38296.808515957244, 58919.70540147358, 58972.41027589669, 15578.9221053894, 15613.14127722986, 15773.211339432983, 15774.921125394529, 15806.446774362843, 10893.346399216072, 11073.723156921142, 11151.442427878736, 11151.553937842395, 11151.776964460665, 18221.45335639933, 18330.63338733218, 18331.0, 18470.81529184718, 18652.34716784906, 7183.281671832775, 7276.0, 7432.368248698921, 7471.442420123829, 7476.813079672943, 869.5261082709939, 953.3719835488798, 999.91000809926, 1011.8178727828914, 1021.5862575656871, 29888.55167172494, 29916.0, 30828.0, 31182.84408577988, 32174.35651286961, 1016.4460369098858, 1034.2966782587762, 1046.3460337289193, 1115.1747706697147, 1124.5445594534226, 15747.921260393854, 16105.0, 16224.594385140466, 16391.09848958295, 16787.832121678628, 160327.0, 161100.0, 162185.0, 162331.0, 162928.0, 56434.0, 56790.716046419504, 56824.14763778546, 57168.0, 57455.0, 1300.7593595184921, 1304.0415294758534, 1309.430397776951, 1340.189185542752, 1350.6285771412743, 29249.122526324245, 30679.0, 30851.382972340878, 31114.0, 31491.212719681276, 50268.74865625795, 50357.24464133114, 50567.74716126396, 50649.74675126601, 50663.24005139852, 416007.0, 417053.0, 419778.0, 421816.0, 421946.0, 27768.0, 28382.290442739097, 28393.0, 28664.713352866205, 29901.10296691103, 44802.77598611986, 44850.775746121064, 46185.538144619466, 46459.303110452696, 46575.53424465848, 39191.60808391879, 39601.40597890977, 39749.60250397459, 41083.7945810281, 41330.0, 38067.238655227295, 40032.599674002886, 40366.79816600898, 41647.0, 41748.40681623013, 34647.13382165365, 38640.0, 38991.0, 39157.41263881101, 39459.0, 34374.65625343715, 34710.479342809376, 37326.0, 38280.0, 38728.41907371448, 26721.33196670099, 27454.725452745217, 27486.725132748415, 27580.187650010655, 27691.0], "value": 18765.03139921082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.74145064257596, 398.3685857915202, 400.25552472401336, 402.2457891453525, 417.49483125418243, 13408.26254555999, 15142.772858407132, 17968.73046904296, 18495.982720950342, 18540.351087711915, 15185.620359491018, 18604.720929186038, 18734.25062997482, 19404.223831046776, 19636.607267854633, 5597.692126933007, 5657.377688454267, 5693.0, 5813.215215945836, 5814.651120932736, 5674.659520428788, 5757.596968212227, 5771.711414429283, 5771.769129234825, 5779.682117483558, 5515.558755299567, 5636.2954630671165, 5704.714764261791, 5749.108888122348, 5750.6262092963825, 5624.91562626561, 5662.49037586615, 5667.744951477193, 5673.716314184295, 5682.289713785777, 5049.6212784041345, 5060.544550990428, 5097.898042039138, 5389.946100538984, 5427.158790387496, 14137.717245655029, 14379.640508987255, 14432.134071955716, 18895.43313700591, 22440.66339004916, 2204.7354317482004, 2269.6368581027123, 2446.13162327373, 2459.0655550890547, 2561.5901455767175, 9951.104400603981, 10062.195024398105, 10248.333858299262, 10791.838122428091, 11032.28290161137, 1910.6274276516085, 1918.1368384227014, 1941.9902900485406, 1984.6229216448828, 1986.384220891514, 67617.0, 69316.6534167331, 69485.0, 71452.6427367865, 76680.61659691666, 10356.326838755456, 10831.566737330577, 11136.944315278372, 11314.434278286053, 11320.886791131983, 15366.308516116802, 15483.380664773507, 15577.143257120968, 15688.76466852998, 15702.607434814221, 7596.126445458733, 7881.211878812073, 7920.247576480225, 8047.396445266629, 8222.671093156207, 7331.74338898136, 7338.522996005243, 7380.667869945865, 7610.8097297568, 7713.267239612228, 4414.205443020287, 4426.623736982393, 4453.4433195850515, 4566.315052742115, 4750.0, 1956.7162761399802, 2042.6323261813016, 2044.8159665630164, 2045.1103769860158, 2058.8147066764063, 837.0875745437502, 871.4422769427572, 940.5673390240429, 992.3946392700446, 1011.5397494140149, 18083.909580452015, 18203.27186912509, 18721.812781872006, 19076.33232836844, 20553.794462055488, 839.6573559768178, 858.4420126917554, 925.3707478914403, 959.9376040557481, 971.4754032822196, 9880.407175569346, 9961.0, 10455.94772026135, 10475.47622618866, 10600.416977066336, 162451.0, 163964.0, 163999.0, 164039.0, 229963.0, 54584.454155458734, 58593.0, 89385.55307223422, 90986.0, 94390.0, 1030.314840630987, 1051.0435503691604, 1056.028453822485, 1057.9576816927238, 1063.984040239397, 17208.655826883143, 17304.567385815455, 17655.205515751564, 17767.555811104827, 17919.46241612754, 41194.58805412027, 41567.96080098022, 42292.577074230096, 43211.13577728491, 43329.13341733211, 60850.695746520985, 61104.0, 61161.69419152876, 61893.69053154706, 62382.0, 8186.345092392713, 8351.081381048201, 8604.139586041596, 8643.91356086431, 8861.113888611088, 12275.447604857982, 12769.744605108031, 12790.74418511606, 12853.0, 12860.742785144432, 10495.160387168855, 10771.730706732395, 10846.945765271123, 10933.453327333442, 11539.8269025963, 10785.40680262593, 11026.614068507564, 11052.889471105507, 11214.327140371604, 11348.375839328915, 10940.56237750481, 11267.267627604508, 11482.138839586898, 11493.333466647457, 11505.827412588986, 7508.624568771649, 7627.351675107678, 7859.724909628136, 8066.516009039477, 8629.784255393413, 10206.489675516046, 10674.306170098918, 10726.195535335037, 10799.946000269949, 11108.666739997812], "value": 8633.477744366963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.2134358118406, 1517.8861585381096, 1646.2098192867422, 1696.0756387768665, 1769.548765064909, 7227.096612923385, 7858.332041776449, 8070.273675369215, 8504.744857654265, 8517.36119791015, 8092.878606820902, 8316.0, 8394.24451799338, 8398.790030249247, 8412.663493460253, 2260.333201705501, 2265.9773402265973, 2280.384296240014, 2292.5071109711407, 2303.0787684925995, 2247.3033359658475, 2262.6945362376114, 2337.614293641547, 2341.929742107731, 2346.061575369857, 2282.897269622871, 2288.187693368855, 2303.389601755536, 2314.3982564533258, 2337.1936681844822, 2274.3859158027403, 2278.396225000376, 2292.5185711000627, 2305.5388922215457, 2310.7111611048535, 2223.1663126327626, 2229.498362868358, 2234.6201145805253, 2239.6752470891793, 2242.1031587365023, 8354.665813367457, 8364.623591938378, 8516.616752246164, 8520.488770673717, 8545.658173673046, 4710.434747830248, 4816.229403295491, 4826.638002149818, 4834.3473631059705, 4837.346958160639, 3198.1524895902603, 3211.855466504013, 3363.209645733251, 3373.1398493384277, 3383.712384447325, 1090.2422816142785, 1118.8601424821898, 1133.3879704959395, 1149.3793351590132, 1153.8384626152344, 10924.672259832218, 10951.014408703175, 10957.780844383067, 10964.945175274152, 10996.945015274952, 4061.6953728469894, 4130.235906357273, 4284.592963668447, 4297.5702429756775, 4338.848140315074, 9429.62281508732, 9432.056794320513, 9437.103475169848, 9458.054194580487, 9470.0, 4850.466448690641, 4858.684185527929, 4861.149298872683, 4861.440934292602, 4874.122657921608, 3796.1458671798623, 4390.912181756411, 4482.058767658828, 4497.168023915586, 4497.280435130363, 3737.7383583149463, 3816.2749077675153, 3836.0, 3853.537575490959, 3951.5455722591696, 1273.5733529267613, 1291.367230057284, 1292.8901043411415, 1293.1012946002627, 1329.5147271245926, 847.8473874702613, 947.8720372749729, 968.5109019944882, 974.9512524373895, 987.9527700637348, 5614.354349249807, 5658.122990936411, 5678.545716342683, 5834.795782147605, 5874.471297583238, 432.19827220506136, 436.7314101827353, 444.60430217106153, 453.2792859353643, 454.1983399300238, 4075.5313138988804, 4148.751074935513, 4154.813033413504, 4160.646345060643, 4197.8320867165585, 9954.552045157985, 10389.792204155874, 10440.164786817037, 10440.63457778974, 10440.791184176274, 10130.44282564466, 10311.07200351972, 10349.844752328721, 10355.430451325099, 10361.222908281909, 7710.267524585268, 7713.961430192813, 7764.184760600168, 7832.177621349676, 7834.451588388872, 5742.483176514133, 5842.415758424124, 5858.94141058584, 5932.555058370725, 5969.462748352669, 9580.808383832424, 9636.662716804878, 9666.420014799134, 9779.119879210904, 9784.80430391374, 9587.568559414703, 9914.40513569188, 9942.453165075991, 9994.650187243411, 9995.0, 6605.438537724155, 6986.895196571953, 7107.82230444243, 7283.817904552428, 7449.776506704808, 7994.880076798969, 8062.919370806451, 8064.798380040546, 8066.0, 8091.433599647969, 7052.365287124184, 7102.680379382837, 7149.106361704787, 7291.41668666516, 7349.154847192427, 7089.0, 7197.49617526789, 7239.529430586995, 7246.6376681166785, 7248.0, 6480.902786458301, 6679.398854103154, 6744.865102698017, 6789.0, 6831.69257383409, 4989.301497790385, 5088.923666144937, 5144.536991670768, 5287.656302340336, 5341.839744807662, 5078.7206703631655, 5084.8220312288895, 5086.3896332440345, 5157.819476318311, 5192.27308176848], "value": 4370.325311517676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.93967119655946, 326.2056891469272, 330.83127604921486, 335.13033677606603, 336.40120585358056, 5339.652922560031, 5426.0, 5527.397054854093, 5556.583256255777, 5583.0, 5436.23322420214, 5467.0, 5492.375032478555, 5509.669419834802, 5510.8071217507395, 4376.343548467724, 4383.408239887623, 4390.0, 4391.780410979454, 4399.604035636792, 4182.64447521961, 4301.139772045603, 4357.651387888977, 4393.516713161565, 4410.228210063242, 4275.636570891463, 4287.078278170193, 4297.914041719164, 4298.333758267474, 4298.591633794785, 4297.957020429787, 4304.139172165548, 4310.612044915957, 4371.562843715603, 4393.472783265996, 3537.6816086552076, 3878.2825177342283, 3880.204558065618, 3885.3783394657003, 3892.2020985697864, 5357.303550538405, 5379.354477462691, 5399.5680345572655, 5408.91886621701, 5414.6480478769145, 4885.169521181408, 4886.0, 4888.022395520875, 4894.706317620954, 4938.925916111261, 5570.61005729595, 5720.828375148711, 5730.0, 5734.025215713339, 5755.712214389264, 4063.3295506241434, 4069.6540794032544, 4074.5721699221453, 4098.73358231717, 4104.220198162369, 5962.34414214436, 6004.919114559378, 6030.427109424598, 6046.667433291167, 6066.939330606726, 4071.1654110907193, 4210.389493523422, 4212.452381190487, 4226.281532139544, 4266.765327906933, 4387.627051700578, 4397.472303323621, 4402.185595664812, 4402.273624851863, 4418.668599855024, 4903.828366007173, 4965.0, 4973.602111831045, 4983.277424773388, 5025.547700706954, 5543.750531226105, 5807.390224026501, 5807.94192058074, 5836.9124463133085, 5858.0, 1499.5951093204992, 1504.8043754311868, 1505.7063872544747, 1507.8718308943862, 1522.8096487939008, 947.5404428852002, 976.5995941663883, 979.9902000979899, 993.7664648807524, 1006.1095930101912, 4909.926351104737, 4920.803167873317, 4930.827421040246, 4947.455779864212, 4968.453470118284, 5092.796288148433, 5196.740162991835, 5203.2195170723935, 5207.3490813648295, 5210.593139852294, 4627.514111018362, 4852.126617208936, 4868.659193856396, 4953.23224900141, 5005.9749701251985, 2744.931376715558, 2748.7526122649056, 2758.813710104674, 2762.958555621667, 2797.202797202787, 5280.524752772192, 5388.568914486832, 5449.373322068013, 5458.9454105458435, 5462.890742185214, 5312.335958005249, 5341.732913354317, 5643.266375371258, 6067.302260240041, 6078.939210607926, 6092.4107254416695, 6100.267967843798, 6105.9694701526205, 6138.785142519991, 6199.721012554446, 5649.887002260014, 5965.28416590012, 5970.76116955317, 5975.087971848967, 6035.1249068885645, 5878.148383259259, 5891.317926296065, 5897.616654917417, 5907.793227237026, 5910.645361278337, 6182.289036760651, 6182.412670796267, 6267.4045965633195, 6270.623762574261, 6284.183056202664, 4037.596240375939, 4079.306517891906, 4151.335786274181, 4192.350185721218, 4192.8532501363525, 5887.8233652990475, 5900.527957763283, 5909.0, 5930.851728706644, 5956.315023772322, 5684.289463817023, 5701.515371193495, 5812.18629391894, 5823.970880145572, 5826.242588463472, 5691.26013618227, 5693.430656934273, 5694.886102278014, 5720.683123335056, 5761.395053519488, 5737.512311453574, 5748.137779333133, 5764.365919748908, 5765.682887441231, 5795.33353664334, 5679.971600141973, 5772.105323674838, 5794.739236734273, 5813.82558523245, 5817.360090390139, 5640.633358831663, 5671.071835575924, 5672.290963629546, 5682.232898558807, 5697.857553561194], "value": 4332.062830385316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.2794495916891, 720.3732752505321, 743.3421422041495, 763.6334559411482, 845.9196376344245, 13800.378982945766, 14707.0, 14713.411463541459, 14747.705045899102, 14994.925025374872, 14824.925875370634, 14963.177025263607, 14989.77515337268, 15058.548243552683, 15113.168775717331, 784.5332027443676, 787.0830482487895, 791.7308115240817, 811.7321283976303, 820.2535692519808, 806.246159840548, 808.4340961327065, 808.8988876390451, 811.2414892075899, 812.0661239574507, 857.1043259793499, 858.4720396955889, 859.188067276424, 859.7119964811795, 861.4056301152185, 841.474078700809, 842.3303473738392, 843.359047124187, 847.8770578266148, 848.8811566380712, 619.0899377914459, 619.9318075011745, 620.057512580879, 623.0809555905004, 624.3506752976898, 12768.233905965579, 12779.936100319532, 12795.552155674506, 12820.166689165175, 12830.177360980662, 14074.788878166733, 14574.344154512966, 14744.705105897821, 14843.0, 14864.925675371662, 11925.403729813475, 12078.637640870787, 12134.514619415213, 12231.633051008395, 12811.743765124738, 3668.137987572918, 3747.700183985302, 3771.302309072803, 3779.130799916035, 3882.941755873636, 79426.0, 81901.59049204775, 81954.59022704848, 82640.58679706624, 83388.0, 11270.492827822767, 11315.83026254607, 11402.543898243977, 11446.0, 11567.305961642329, 21868.89065554662, 21914.0, 21927.451813704785, 21927.67108493374, 21928.232511862007, 8105.55419451924, 8106.351491880635, 8237.629306681094, 8551.187637174458, 8705.260052895575, 4739.336492890998, 4773.212419950739, 4790.616750659939, 4892.755362231874, 4933.50664933511, 3322.2857085726687, 3402.5576675032585, 3428.879989200416, 3433.9313213735586, 3442.6729460701195, 537.5833728860086, 575.323994306688, 577.0680351232812, 592.7184587320988, 594.3402822866615, 589.5961266532439, 606.5935822998601, 619.0899377914459, 621.2203684376079, 633.4457349818908, 8820.294376449869, 9206.769830754285, 9208.171264586219, 9634.855477167848, 9643.662471813454, 606.7421345927963, 631.2488139114439, 652.2890049845691, 683.2927919603187, 688.3082502085472, 4268.274393353137, 4479.664025198123, 4547.3406356078185, 4577.542245775396, 4595.931061034087, 120036.3998180021, 123648.0, 124049.37975310066, 124854.0, 127471.36264318804, 86175.56912215524, 103872.0, 104724.47637761915, 106908.0, 107486.46256768666, 88039.55980220057, 89473.0, 91802.4290206668, 93767.53116234374, 94622.52688736512, 8177.05963814169, 8455.239028487465, 8580.227779499875, 8703.173198546128, 8744.213020827901, 52151.73924130355, 52300.73849630728, 52681.209781852536, 52903.470965291395, 53344.1998370017, 72348.27651723416, 78577.60711196407, 78789.60605196937, 80394.59802701183, 80622.59688701518, 11670.824937626112, 11676.591319304123, 11732.530698771954, 11796.643878185208, 12229.93885030569, 12285.815712764494, 12620.55828046014, 13273.336333183495, 13394.0, 13927.373268202753, 13460.93269533646, 14183.069647676266, 14296.785548216578, 14624.70750584961, 14885.181315027778, 12909.419076141408, 13537.323133843465, 13548.661283467993, 13674.93162534181, 13849.584512464642, 13839.377228024561, 14071.507497237548, 14365.569032929028, 14454.494092706705, 14922.104673719612, 10092.34399764013, 10426.374417534973, 10506.632267870587, 10720.62477813304, 10868.184886133413, 10751.731206719582, 11153.275037122561, 12167.87832121703, 12351.444185011876, 12415.130940834055], "value": 7443.696599135543, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 113.0, 114.0, 113.0, 112.0, 113.0, 114.0, 113.0, 131.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 145.0, 186.0, 122.0, 149.0, 153.0, 120.0, 181.0, 123.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 174.0, 161.0, 165.0, 166.0, 165.0, 163.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 176.0, 77.0, 77.0, 77.0, 76.0, 178.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 148.0, 83.0, 85.0, 83.0, 145.0, 82.0, 88.0, 143.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 98.0, 95.0, 96.0, 96.0, 98.0, 96.0, 97.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 55.0, 55.0, 56.0, 54.0, 56.0, 53.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 68.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 86.0, 86.0, 81.0, 80.0, 80.0, 78.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 141.0, 128.0, 133.0, 151.0, 132.0, 138.0, 183.0, 128.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 165.0, 164.0, 163.0, 165.0, 163.0, 166.0, 170.0, 169.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 67.0, 66.0, 68.0, 74.0, 66.0, 65.0, 65.0], "value": 67.3, "unit": "score"}]}]} 12:01:05 INFO - Return code: 0 12:01:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:01:05 ERROR - # TBPL SUCCESS # 12:01:05 INFO - Running post-action listener: _resource_record_post_action 12:01:05 INFO - [mozharness: 2016-08-30 19:01:05.583878Z] Finished run-tests step (success) 12:01:05 INFO - Running post-run listener: _resource_record_post_run 12:01:05 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7847936; Write bytes: 365469696; Read time: 1660; Write time: 254188 12:01:05 INFO - TinderboxPrint: CPU usage
13.4% 12:01:05 INFO - TinderboxPrint: I/O read bytes / time
7,847,936 / 1,660 12:01:05 INFO - TinderboxPrint: I/O write bytes / time
365,469,696 / 254,188 12:01:05 INFO - TinderboxPrint: CPU idle
8,264.6 (86.6%) 12:01:05 INFO - TinderboxPrint: CPU user
1,215.1 (12.7%) 12:01:05 INFO - TinderboxPrint: Swap in / out
0 / 0 12:01:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1036288; Read time: 0; Write time: 44 12:01:05 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 5607424; Write bytes: 296169472; Read time: 1092; Write time: 204712 12:01:06 INFO - Running post-run listener: _upload_blobber_files 12:01:06 INFO - Blob upload gear active. 12:01:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:01:06 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 12:01:06 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'] 12:01:06 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 12:01:06 INFO - (blobuploader) - INFO - Open directory for files ... 12:01:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:01:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:01:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:07 INFO - (blobuploader) - INFO - Done attempting. 12:01:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:01:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:01:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:08 INFO - (blobuploader) - INFO - Done attempting. 12:01:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:01:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:01:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:12 INFO - (blobuploader) - INFO - Done attempting. 12:01:12 INFO - (blobuploader) - INFO - Iteration through files over. 12:01:12 INFO - Return code: 0 12:01:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:01:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:01:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e8a124a7ba7138f9d812c6f6cf15c1d9dc6baf525fee735318d5c7d33e733b28d02bd7cb1422019f1368a1dbbc94e2e3e70f3d5c1a1ce6594d18ef2aa5f5c6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc11f449a1639e30bef9fd560eb2552249ae63b1037c0fa1d803b70021233271a21b91ffb78dd1b5e39bdca2cab8a55a90b6d4882f53f105deba72cfbd25f00f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c9dfd8212db1d99033beb74126918e4ee0f36a711f4ef78f9ee9466c9e142308af862413db680e62bf1e73f9f80ccf5a823cce1087c2716ffd15dac426af418"} 12:01:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:01:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:01:12 INFO - Contents: 12:01:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e8a124a7ba7138f9d812c6f6cf15c1d9dc6baf525fee735318d5c7d33e733b28d02bd7cb1422019f1368a1dbbc94e2e3e70f3d5c1a1ce6594d18ef2aa5f5c6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc11f449a1639e30bef9fd560eb2552249ae63b1037c0fa1d803b70021233271a21b91ffb78dd1b5e39bdca2cab8a55a90b6d4882f53f105deba72cfbd25f00f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c9dfd8212db1d99033beb74126918e4ee0f36a711f4ef78f9ee9466c9e142308af862413db680e62bf1e73f9f80ccf5a823cce1087c2716ffd15dac426af418"} 12:01:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:01:12 INFO - Copying logs to upload dir... 12:01:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:01:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.341234 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-30 12:01:13.047624) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 12:01:13.057478) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161 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/4e8a124a7ba7138f9d812c6f6cf15c1d9dc6baf525fee735318d5c7d33e733b28d02bd7cb1422019f1368a1dbbc94e2e3e70f3d5c1a1ce6594d18ef2aa5f5c6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc11f449a1639e30bef9fd560eb2552249ae63b1037c0fa1d803b70021233271a21b91ffb78dd1b5e39bdca2cab8a55a90b6d4882f53f105deba72cfbd25f00f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c9dfd8212db1d99033beb74126918e4ee0f36a711f4ef78f9ee9466c9e142308af862413db680e62bf1e73f9f80ccf5a823cce1087c2716ffd15dac426af418"} build_url:https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.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/4e8a124a7ba7138f9d812c6f6cf15c1d9dc6baf525fee735318d5c7d33e733b28d02bd7cb1422019f1368a1dbbc94e2e3e70f3d5c1a1ce6594d18ef2aa5f5c6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc11f449a1639e30bef9fd560eb2552249ae63b1037c0fa1d803b70021233271a21b91ffb78dd1b5e39bdca2cab8a55a90b6d4882f53f105deba72cfbd25f00f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c9dfd8212db1d99033beb74126918e4ee0f36a711f4ef78f9ee9466c9e142308af862413db680e62bf1e73f9f80ccf5a823cce1087c2716ffd15dac426af418"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 12:01:13.083500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 12:01:13.083849) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1472582174.619988-56575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 12:01:13.164999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 12:01:13.168350) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 12:01:13.168643) ========= ========= Total master_lag: 0.51 =========