builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1467239428.71 results: success (0) buildid: 20160629150227 builduid: e7e8e743a1f84dd494aee6616e70cd3d revision: b6ad395da0e5c99a4f4b6a5554d7df03a047393b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.708656) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.709259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.709692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.726312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.726725) ========= 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=fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 15:30:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-29 15:30:28 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.847624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.847937) ========= 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=fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:28.897487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 15:30:28.897847) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6ad395da0e5c99a4f4b6a5554d7df03a047393b --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 b6ad395da0e5c99a4f4b6a5554d7df03a047393b --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=fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 15:30:29,026 truncating revision to first 12 chars 2016-06-29 15:30:29,027 Setting DEBUG logging. 2016-06-29 15:30:29,027 attempt 1/10 2016-06-29 15:30:29,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6ad395da0e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 15:30:30,415 unpacking tar archive at: fx-team-b6ad395da0e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.733240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 15:30:30.644714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:30.645031) ========= script_repo_revision: b6ad395da0e5c99a4f4b6a5554d7df03a047393b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:30.645413) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:30.645690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:30:30.654737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2016-06-29 15:30:30.655019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:30 INFO - MultiFileLogger online at 20160629 15:30:30 in /builds/slave/test 15:30:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:30:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:30 INFO - {'append_to_log': False, 15:30:30 INFO - 'base_work_dir': '/builds/slave/test', 15:30:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:30:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:30 INFO - 'branch': 'Fx-Team-Non-PGO', 15:30:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:30 INFO - 'config_files': ('talos/linux_config.py',), 15:30:30 INFO - 'default_actions': ('clobber', 15:30:30 INFO - 'read-buildbot-config', 15:30:30 INFO - 'download-and-extract', 15:30:30 INFO - 'populate-webroot', 15:30:30 INFO - 'create-virtualenv', 15:30:30 INFO - 'install', 15:30:30 INFO - 'run-tests'), 15:30:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:30 INFO - 'download_minidump_stackwalk': True, 15:30:30 INFO - 'download_symbols': 'ondemand', 15:30:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:30 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:30 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:30 INFO - 'installer_path': 'installer.exe', 15:30:30 INFO - 'log_level': 'info', 15:30:30 INFO - 'log_name': 'talos', 15:30:30 INFO - 'log_to_console': True, 15:30:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:30 INFO - 'opt_config_files': (), 15:30:30 INFO - 'pip_index': False, 15:30:30 INFO - 'sps_profile': False, 15:30:30 INFO - 'sps_profile_interval': 0, 15:30:30 INFO - 'suite': 'dromaeojs-e10s', 15:30:30 INFO - 'system_bits': '32', 15:30:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:30 INFO - 'title': 'talos-linux64-ix-048', 15:30:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:30 INFO - 'use_talos_json': True, 15:30:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:30 INFO - 'work_dir': 'build'} 15:30:30 INFO - ##### 15:30:30 INFO - ##### Running clobber step. 15:30:30 INFO - ##### 15:30:30 INFO - Running pre-action listener: _resource_record_pre_action 15:30:30 INFO - Running main action method: clobber 15:30:30 INFO - rmtree: /builds/slave/test/build 15:30:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:31 INFO - Running post-action listener: _resource_record_post_action 15:30:31 INFO - ##### 15:30:31 INFO - ##### Finished clobber step (success) 15:30:31 INFO - ##### 15:30:31 INFO - ##### 15:30:31 INFO - ##### Running read-buildbot-config step. 15:30:31 INFO - ##### 15:30:31 INFO - Running pre-action listener: _resource_record_pre_action 15:30:31 INFO - Running main action method: read_buildbot_config 15:30:31 INFO - Using buildbot properties: 15:30:31 INFO - { 15:30:31 INFO - "project": "", 15:30:31 INFO - "product": "firefox", 15:30:31 INFO - "script_repo_revision": "production", 15:30:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:30:31 INFO - "repository": "", 15:30:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:30:31 INFO - "buildid": "20160629150227", 15:30:31 INFO - "pgo_build": "False", 15:30:31 INFO - "basedir": "/builds/slave/test", 15:30:31 INFO - "buildnumber": 1395, 15:30:31 INFO - "slavename": "talos-linux64-ix-048", 15:30:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:30:31 INFO - "platform": "ubuntu64_hw", 15:30:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:30:31 INFO - "branch": "fx-team", 15:30:31 INFO - "repo_path": "integration/fx-team", 15:30:31 INFO - "revision": "b6ad395da0e5c99a4f4b6a5554d7df03a047393b", 15:30:31 INFO - "stage_platform": "linux64", 15:30:31 INFO - "builduid": "e7e8e743a1f84dd494aee6616e70cd3d", 15:30:31 INFO - "slavebuilddir": "test" 15:30:31 INFO - } 15:30:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:30:31 INFO - Running post-action listener: _resource_record_post_action 15:30:31 INFO - ##### 15:30:31 INFO - ##### Finished read-buildbot-config step (success) 15:30:31 INFO - ##### 15:30:31 INFO - ##### 15:30:31 INFO - ##### Running download-and-extract step. 15:30:31 INFO - ##### 15:30:31 INFO - Running pre-action listener: _resource_record_pre_action 15:30:31 INFO - Running main action method: download_and_extract 15:30:31 INFO - mkdir: /builds/slave/test/build/tests 15:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:31 INFO - https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:30:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:30:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:30:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:30:32 INFO - Downloaded 1361 bytes. 15:30:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:30:32 INFO - Using the following test package requirements: 15:30:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:30:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:30:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'jsshell-linux-x86_64.zip'], 15:30:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:30:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:30:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:30:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:30:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:30:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:32 INFO - https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:30:37 INFO - Downloaded 22701715 bytes. 15:30:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:30:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:30:38 INFO - Return code: 0 15:30:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:38 INFO - https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:30:42 INFO - Downloaded 22701715 bytes. 15:30:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:30:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:30:43 INFO - Return code: 0 15:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:43 INFO - https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:30:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:31:22 INFO - Downloaded 14405245 bytes. 15:31:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:31:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:31:22 INFO - Return code: 0 15:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:22 INFO - https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:31:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:31:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:31:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:32:42 INFO - Downloaded 56467800 bytes. 15:32:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:32:42 INFO - mkdir: /builds/slave/test/properties 15:32:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:32:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:32:42 INFO - Contents: 15:32:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:32:43 INFO - Running post-action listener: _resource_record_post_action 15:32:43 INFO - Running post-action listener: set_extra_try_arguments 15:32:43 INFO - ##### 15:32:43 INFO - ##### Finished download-and-extract step (success) 15:32:43 INFO - ##### 15:32:43 INFO - ##### 15:32:43 INFO - ##### Running populate-webroot step. 15:32:43 INFO - ##### 15:32:43 INFO - Running pre-action listener: _resource_record_pre_action 15:32:43 INFO - Running main action method: populate_webroot 15:32:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:32:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:32:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:32:43 INFO - '--tppagecycles', 15:32:43 INFO - '7'], 15:32:43 INFO - 'tests': ['tsvgm']}}, 15:32:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:32:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:32:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:32:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:32:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:32:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['damp', 'tps']}, 15:32:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'tests': ['damp', 'tps']}, 15:32:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['dromaeo_dom']}, 15:32:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:32:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['basic_compositor_video']}, 15:32:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:32:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['a11yr', 15:32:43 INFO - 'ts_paint', 15:32:43 INFO - 'tpaint', 15:32:43 INFO - 'sessionrestore', 15:32:43 INFO - 'sessionrestore_no_auto_restore', 15:32:43 INFO - 'tabpaint']}, 15:32:43 INFO - 'other-e10s': {'tests': ['a11yr', 15:32:43 INFO - 'ts_paint', 15:32:43 INFO - 'tpaint', 15:32:43 INFO - 'sessionrestore', 15:32:43 INFO - 'sessionrestore_no_auto_restore', 15:32:43 INFO - 'tabpaint']}, 15:32:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:32:43 INFO - 'ts_paint', 15:32:43 INFO - 'tpaint', 15:32:43 INFO - 'sessionrestore', 15:32:43 INFO - 'sessionrestore_no_auto_restore', 15:32:43 INFO - 'tabpaint']}, 15:32:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:32:43 INFO - 'ts_paint', 15:32:43 INFO - 'tpaint', 15:32:43 INFO - 'sessionrestore', 15:32:43 INFO - 'sessionrestore_no_auto_restore', 15:32:43 INFO - 'tabpaint']}, 15:32:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['a11yr', 15:32:43 INFO - 'ts_paint', 15:32:43 INFO - 'tpaint', 15:32:43 INFO - 'sessionrestore', 15:32:43 INFO - 'sessionrestore_no_auto_restore', 15:32:43 INFO - 'tabpaint']}, 15:32:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['a11yr', 15:32:43 INFO - 'ts_paint', 15:32:43 INFO - 'tpaint', 15:32:43 INFO - 'sessionrestore', 15:32:43 INFO - 'sessionrestore_no_auto_restore', 15:32:43 INFO - 'tabpaint']}, 15:32:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['tsvgx', 15:32:43 INFO - 'tsvgr_opacity', 15:32:43 INFO - 'tart', 15:32:43 INFO - 'tscrollx', 15:32:43 INFO - 'cart']}, 15:32:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:32:43 INFO - 'tsvgr_opacity', 15:32:43 INFO - 'tart', 15:32:43 INFO - 'tscrollx', 15:32:43 INFO - 'cart']}, 15:32:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'talos_options': ['--disable-e10s'], 15:32:43 INFO - 'tests': ['tp5o']}, 15:32:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'tests': ['tp5o']}, 15:32:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'talos_options': ['--disable-e10s', 15:32:43 INFO - '--xperf_path', 15:32:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:43 INFO - 'tests': ['tp5n']}, 15:32:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:32:43 INFO - 'talos_options': ['--xperf_path', 15:32:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:32:43 INFO - 'tests': ['tp5n']}}, 15:32:43 INFO - 'talos.zip': {'path': '', 15:32:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:32:43 INFO - Running post-action listener: _resource_record_post_action 15:32:43 INFO - ##### 15:32:43 INFO - ##### Finished populate-webroot step (success) 15:32:43 INFO - ##### 15:32:43 INFO - ##### 15:32:43 INFO - ##### Running create-virtualenv step. 15:32:43 INFO - ##### 15:32:43 INFO - Running pre-action listener: _resource_record_pre_action 15:32:43 INFO - Running main action method: create_virtualenv 15:32:43 INFO - Creating virtualenv /builds/slave/test/build/venv 15:32:43 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 15:32:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:32:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:32:43 INFO - Using real prefix '/usr' 15:32:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:32:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:32:45 INFO - Installing pip.................done. 15:32:45 INFO - Return code: 0 15:32:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:45 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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:32:45 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 15:32:45 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 15:32:45 INFO - Using env: {'DISPLAY': ':0', 15:32:45 INFO - 'HOME': '/home/cltbld', 15:32:45 INFO - 'LANG': 'en_US.UTF-8', 15:32:45 INFO - 'LANGUAGE': 'en_US:en', 15:32:45 INFO - 'LOGNAME': 'cltbld', 15:32:45 INFO - 'MAIL': '/var/mail/cltbld', 15:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:45 INFO - 'MOZ_NO_REMOTE': '1', 15:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:45 INFO - 'NO_EM_RESTART': '1', 15:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:45 INFO - 'PWD': '/builds/slave/test', 15:32:45 INFO - 'SHELL': '/bin/bash', 15:32:45 INFO - 'SHLVL': '1', 15:32:45 INFO - 'TERM': 'linux', 15:32:45 INFO - 'TMOUT': '86400', 15:32:45 INFO - 'USER': 'cltbld', 15:32:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:45 INFO - '_': '/tools/buildbot/bin/python'} 15:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:45 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 15:32:45 INFO - Cleaning up... 15:32:45 INFO - Return code: 0 15:32:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:45 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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:32:45 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 15:32:45 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 15:32:45 INFO - Using env: {'DISPLAY': ':0', 15:32:45 INFO - 'HOME': '/home/cltbld', 15:32:45 INFO - 'LANG': 'en_US.UTF-8', 15:32:45 INFO - 'LANGUAGE': 'en_US:en', 15:32:45 INFO - 'LOGNAME': 'cltbld', 15:32:45 INFO - 'MAIL': '/var/mail/cltbld', 15:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:45 INFO - 'MOZ_NO_REMOTE': '1', 15:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:45 INFO - 'NO_EM_RESTART': '1', 15:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:45 INFO - 'PWD': '/builds/slave/test', 15:32:45 INFO - 'SHELL': '/bin/bash', 15:32:45 INFO - 'SHLVL': '1', 15:32:45 INFO - 'TERM': 'linux', 15:32:45 INFO - 'TMOUT': '86400', 15:32:45 INFO - 'USER': 'cltbld', 15:32:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:45 INFO - '_': '/tools/buildbot/bin/python'} 15:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:46 INFO - Downloading/unpacking psutil>=3.1.1 15:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:48 INFO - Installing collected packages: psutil 15:32:48 INFO - Running setup.py install for psutil 15:32:48 INFO - building 'psutil._psutil_linux' extension 15:32:48 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 15:32:48 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 15:32:48 INFO - building 'psutil._psutil_posix' extension 15:32:48 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 15:32:48 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 15:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:32:48 INFO - Successfully installed psutil 15:32:48 INFO - Cleaning up... 15:32:48 INFO - Return code: 0 15:32:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:32: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 15:32: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 15:32:48 INFO - Using env: {'DISPLAY': ':0', 15:32:48 INFO - 'HOME': '/home/cltbld', 15:32:48 INFO - 'LANG': 'en_US.UTF-8', 15:32:48 INFO - 'LANGUAGE': 'en_US:en', 15:32:48 INFO - 'LOGNAME': 'cltbld', 15:32:48 INFO - 'MAIL': '/var/mail/cltbld', 15:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:48 INFO - 'MOZ_NO_REMOTE': '1', 15:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:48 INFO - 'NO_EM_RESTART': '1', 15:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:48 INFO - 'PWD': '/builds/slave/test', 15:32:48 INFO - 'SHELL': '/bin/bash', 15:32:48 INFO - 'SHLVL': '1', 15:32:48 INFO - 'TERM': 'linux', 15:32:48 INFO - 'TMOUT': '86400', 15:32:48 INFO - 'USER': 'cltbld', 15:32:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:48 INFO - '_': '/tools/buildbot/bin/python'} 15:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:32:50 INFO - Installing collected packages: mozsystemmonitor 15:32:50 INFO - Running setup.py install for mozsystemmonitor 15:32:50 INFO - Successfully installed mozsystemmonitor 15:32:50 INFO - Cleaning up... 15:32:50 INFO - Return code: 0 15:32:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:32: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 15:32: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 15:32:50 INFO - Using env: {'DISPLAY': ':0', 15:32:50 INFO - 'HOME': '/home/cltbld', 15:32:50 INFO - 'LANG': 'en_US.UTF-8', 15:32:50 INFO - 'LANGUAGE': 'en_US:en', 15:32:50 INFO - 'LOGNAME': 'cltbld', 15:32:50 INFO - 'MAIL': '/var/mail/cltbld', 15:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:50 INFO - 'MOZ_NO_REMOTE': '1', 15:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:50 INFO - 'NO_EM_RESTART': '1', 15:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:50 INFO - 'PWD': '/builds/slave/test', 15:32:50 INFO - 'SHELL': '/bin/bash', 15:32:50 INFO - 'SHLVL': '1', 15:32:50 INFO - 'TERM': 'linux', 15:32:50 INFO - 'TMOUT': '86400', 15:32:50 INFO - 'USER': 'cltbld', 15:32:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:50 INFO - '_': '/tools/buildbot/bin/python'} 15:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:51 INFO - Downloading/unpacking jsonschema==2.5.1 15:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:32:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:53 INFO - Downloading functools32-3.2.3-2.tar.gz 15:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:32:53 INFO - warning: no files found matching '*.txt' 15:32:53 INFO - no previously-included directories found matching 'build' 15:32:53 INFO - no previously-included directories found matching 'dist' 15:32:53 INFO - no previously-included directories found matching '.git*' 15:32:53 INFO - Installing collected packages: jsonschema, functools32 15:32:53 INFO - Running setup.py install for functools32 15:32:53 INFO - warning: no files found matching '*.txt' 15:32:53 INFO - no previously-included directories found matching 'build' 15:32:53 INFO - no previously-included directories found matching 'dist' 15:32:53 INFO - no previously-included directories found matching '.git*' 15:32:53 INFO - Successfully installed jsonschema functools32 15:32:53 INFO - Cleaning up... 15:32:53 INFO - Return code: 0 15:32:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32: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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:32: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 15:32: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 15:32:53 INFO - Using env: {'DISPLAY': ':0', 15:32:53 INFO - 'HOME': '/home/cltbld', 15:32:53 INFO - 'LANG': 'en_US.UTF-8', 15:32:53 INFO - 'LANGUAGE': 'en_US:en', 15:32:53 INFO - 'LOGNAME': 'cltbld', 15:32:53 INFO - 'MAIL': '/var/mail/cltbld', 15:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:53 INFO - 'MOZ_NO_REMOTE': '1', 15:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:53 INFO - 'NO_EM_RESTART': '1', 15:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:53 INFO - 'PWD': '/builds/slave/test', 15:32:53 INFO - 'SHELL': '/bin/bash', 15:32:53 INFO - 'SHLVL': '1', 15:32:53 INFO - 'TERM': 'linux', 15:32:53 INFO - 'TMOUT': '86400', 15:32:53 INFO - 'USER': 'cltbld', 15:32:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:53 INFO - '_': '/tools/buildbot/bin/python'} 15:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:32:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:32:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32: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 15:32:56 INFO - Downloading docopt-0.6.1.tar.gz 15:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:32:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:32:56 INFO - Running setup.py install for blobuploader 15:32:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:32:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:32:56 INFO - Running setup.py install for requests 15:32:56 INFO - Running setup.py install for docopt 15:32:56 INFO - Successfully installed blobuploader requests docopt 15:32:56 INFO - Cleaning up... 15:32:56 INFO - Return code: 0 15:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:32:56 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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:32:56 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 15:32:56 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 15:32:56 INFO - Using env: {'DISPLAY': ':0', 15:32:56 INFO - 'HOME': '/home/cltbld', 15:32:56 INFO - 'LANG': 'en_US.UTF-8', 15:32:56 INFO - 'LANGUAGE': 'en_US:en', 15:32:56 INFO - 'LOGNAME': 'cltbld', 15:32:56 INFO - 'MAIL': '/var/mail/cltbld', 15:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:56 INFO - 'MOZ_NO_REMOTE': '1', 15:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:56 INFO - 'NO_EM_RESTART': '1', 15:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:56 INFO - 'PWD': '/builds/slave/test', 15:32:56 INFO - 'SHELL': '/bin/bash', 15:32:56 INFO - 'SHLVL': '1', 15:32:56 INFO - 'TERM': 'linux', 15:32:56 INFO - 'TMOUT': '86400', 15:32:56 INFO - 'USER': 'cltbld', 15:32:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:56 INFO - '_': '/tools/buildbot/bin/python'} 15:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:32:57 INFO - Running setup.py (path:/tmp/pip-6ztzRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:32:57 INFO - Running setup.py (path:/tmp/pip-yk24ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:32:57 INFO - Running setup.py (path:/tmp/pip-pnmpE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:32:57 INFO - Running setup.py (path:/tmp/pip-SDpgOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:32:57 INFO - Running setup.py (path:/tmp/pip-4AbRyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:32:57 INFO - Running setup.py (path:/tmp/pip-TfB_TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:32:57 INFO - Running setup.py (path:/tmp/pip-qYHEvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:32:57 INFO - Running setup.py (path:/tmp/pip-wLjpli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:32:57 INFO - Running setup.py (path:/tmp/pip-7Nb9q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:32:57 INFO - Running setup.py (path:/tmp/pip-Ld8HrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:32:57 INFO - Running setup.py (path:/tmp/pip-MOkaMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:32:57 INFO - Running setup.py (path:/tmp/pip-rzwmqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:32:58 INFO - Running setup.py (path:/tmp/pip-yLIMXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:32:58 INFO - Running setup.py (path:/tmp/pip-nkfh_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:58 INFO - Running setup.py (path:/tmp/pip-rvf58J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:32:58 INFO - Running setup.py (path:/tmp/pip-fZP9_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:32:58 INFO - Running setup.py (path:/tmp/pip-UtYons-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:32:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:32:58 INFO - Running setup.py install for manifestparser 15:32:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:32:58 INFO - Running setup.py install for mozcrash 15:32:58 INFO - Running setup.py install for mozdebug 15:32:58 INFO - Running setup.py install for mozdevice 15:32:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:32:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:32:58 INFO - Running setup.py install for mozfile 15:32:58 INFO - Running setup.py install for mozhttpd 15:32:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozinfo 15:32:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozInstall 15:32:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozleak 15:32:59 INFO - Running setup.py install for mozlog 15:32:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for moznetwork 15:32:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozprocess 15:32:59 INFO - Running setup.py install for mozprofile 15:32:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozrunner 15:32:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:32:59 INFO - Running setup.py install for mozscreenshot 15:32:59 INFO - Running setup.py install for moztest 15:33:00 INFO - Running setup.py install for mozversion 15:33:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:33:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:33:00 INFO - Cleaning up... 15:33:00 INFO - Return code: 0 15:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33: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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:33: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 15:33: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 15:33:00 INFO - Using env: {'DISPLAY': ':0', 15:33:00 INFO - 'HOME': '/home/cltbld', 15:33:00 INFO - 'LANG': 'en_US.UTF-8', 15:33:00 INFO - 'LANGUAGE': 'en_US:en', 15:33:00 INFO - 'LOGNAME': 'cltbld', 15:33:00 INFO - 'MAIL': '/var/mail/cltbld', 15:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:00 INFO - 'MOZ_NO_REMOTE': '1', 15:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:00 INFO - 'NO_EM_RESTART': '1', 15:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:00 INFO - 'PWD': '/builds/slave/test', 15:33:00 INFO - 'SHELL': '/bin/bash', 15:33:00 INFO - 'SHLVL': '1', 15:33:00 INFO - 'TERM': 'linux', 15:33:00 INFO - 'TMOUT': '86400', 15:33:00 INFO - 'USER': 'cltbld', 15:33:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:00 INFO - '_': '/tools/buildbot/bin/python'} 15:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:33:00 INFO - Running setup.py (path:/tmp/pip-EGgaaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:33:00 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)) 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:33:00 INFO - Running setup.py (path:/tmp/pip-ygJFof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:33:00 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)) 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:33:00 INFO - Running setup.py (path:/tmp/pip-br1_PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:33:00 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)) 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:33:00 INFO - Running setup.py (path:/tmp/pip-ffvbPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:33:00 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)) 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:33:00 INFO - Running setup.py (path:/tmp/pip-4xHFvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:33:00 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)) 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:33:00 INFO - Running setup.py (path:/tmp/pip-fiu2HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:33:00 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)) 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:33:00 INFO - Running setup.py (path:/tmp/pip-JiF6Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:33:00 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)) 15:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:33:00 INFO - Running setup.py (path:/tmp/pip-jAZTaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:33: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)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:33:01 INFO - Running setup.py (path:/tmp/pip-mqRQ6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:33: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)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:33:01 INFO - Running setup.py (path:/tmp/pip-6fIy5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:33:01 INFO - Running setup.py (path:/tmp/pip-VToy66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:33: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)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:33:01 INFO - Running setup.py (path:/tmp/pip-Xfo2K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:33:01 INFO - Running setup.py (path:/tmp/pip-86bsnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:33:01 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)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:33:01 INFO - Running setup.py (path:/tmp/pip-lhX8Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:01 INFO - Running setup.py (path:/tmp/pip-CG2iaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:33:01 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)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:33:01 INFO - Running setup.py (path:/tmp/pip-A9AzW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:33:01 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)) 15:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:33:01 INFO - Running setup.py (path:/tmp/pip-Z6qK4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 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)) 15:33:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:33:01 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 15:33:01 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 15:33:01 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 15:33:01 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 15:33:01 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 15:33:01 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 15:33:03 INFO - Downloading blessings-1.6.tar.gz 15:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:33:03 INFO - Installing collected packages: blessings 15:33:03 INFO - Running setup.py install for blessings 15:33:03 INFO - Successfully installed blessings 15:33:03 INFO - Cleaning up... 15:33:03 INFO - Return code: 0 15:33:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:04 INFO - Reading from file tmpfile_stdout 15:33:04 INFO - Current package versions: 15:33:04 INFO - argparse == 1.2.1 15:33:04 INFO - blessings == 1.6 15:33:04 INFO - blobuploader == 1.2.4 15:33:04 INFO - docopt == 0.6.1 15:33:04 INFO - functools32 == 3.2.3-2 15:33:04 INFO - jsonschema == 2.5.1 15:33:04 INFO - manifestparser == 1.1 15:33:04 INFO - mozInstall == 1.12 15:33:04 INFO - mozcrash == 0.17 15:33:04 INFO - mozdebug == 0.1 15:33:04 INFO - mozdevice == 0.48 15:33:04 INFO - mozfile == 1.2 15:33:04 INFO - mozhttpd == 0.7 15:33:04 INFO - mozinfo == 0.9 15:33:04 INFO - mozleak == 0.1 15:33:04 INFO - mozlog == 3.2 15:33:04 INFO - moznetwork == 0.27 15:33:04 INFO - mozprocess == 0.22 15:33:04 INFO - mozprofile == 0.28 15:33:04 INFO - mozrunner == 6.11 15:33:04 INFO - mozscreenshot == 0.1 15:33:04 INFO - mozsystemmonitor == 0.3 15:33:04 INFO - moztest == 0.7 15:33:04 INFO - mozversion == 1.4 15:33:04 INFO - psutil == 3.1.1 15:33:04 INFO - requests == 1.2.3 15:33:04 INFO - wsgiref == 0.1.2 15:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:33:04 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 15:33:04 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 15:33:04 INFO - Using env: {'DISPLAY': ':0', 15:33:04 INFO - 'HOME': '/home/cltbld', 15:33:04 INFO - 'LANG': 'en_US.UTF-8', 15:33:04 INFO - 'LANGUAGE': 'en_US:en', 15:33:04 INFO - 'LOGNAME': 'cltbld', 15:33:04 INFO - 'MAIL': '/var/mail/cltbld', 15:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:04 INFO - 'MOZ_NO_REMOTE': '1', 15:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:04 INFO - 'NO_EM_RESTART': '1', 15:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:04 INFO - 'PWD': '/builds/slave/test', 15:33:04 INFO - 'SHELL': '/bin/bash', 15:33:04 INFO - 'SHLVL': '1', 15:33:04 INFO - 'TERM': 'linux', 15:33:04 INFO - 'TMOUT': '86400', 15:33:04 INFO - 'USER': 'cltbld', 15:33:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:04 INFO - '_': '/tools/buildbot/bin/python'} 15:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 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)) 15:33:04 INFO - Cleaning up... 15:33:04 INFO - Return code: 0 15:33:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:33:04 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 0x13e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, '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': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', '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 15:33:04 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 15:33:04 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 15:33:04 INFO - Using env: {'DISPLAY': ':0', 15:33:04 INFO - 'HOME': '/home/cltbld', 15:33:04 INFO - 'LANG': 'en_US.UTF-8', 15:33:04 INFO - 'LANGUAGE': 'en_US:en', 15:33:04 INFO - 'LOGNAME': 'cltbld', 15:33:04 INFO - 'MAIL': '/var/mail/cltbld', 15:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:04 INFO - 'MOZ_NO_REMOTE': '1', 15:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:04 INFO - 'NO_EM_RESTART': '1', 15:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:04 INFO - 'PWD': '/builds/slave/test', 15:33:04 INFO - 'SHELL': '/bin/bash', 15:33:04 INFO - 'SHLVL': '1', 15:33:04 INFO - 'TERM': 'linux', 15:33:04 INFO - 'TMOUT': '86400', 15:33:04 INFO - 'USER': 'cltbld', 15:33:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:04 INFO - '_': '/tools/buildbot/bin/python'} 15:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:33:04 INFO - Cleaning up... 15:33:04 INFO - Return code: 0 15:33:04 INFO - Running post-action listener: _resource_record_post_action 15:33:04 INFO - Running post-action listener: _start_resource_monitoring 15:33:04 INFO - Starting resource monitoring. 15:33:04 INFO - ##### 15:33:04 INFO - ##### Finished create-virtualenv step (success) 15:33:04 INFO - ##### 15:33:04 INFO - ##### 15:33:04 INFO - ##### Running install step. 15:33:04 INFO - ##### 15:33:04 INFO - Running pre-action listener: _resource_record_pre_action 15:33:04 INFO - Running main action method: install 15:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:33:04 INFO - Reading from file tmpfile_stdout 15:33:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:33:04 INFO - Reading from file tmpfile_stdout 15:33:04 INFO - Output received: 15:33:04 INFO - Usage: mozinstall [options] installer 15:33:04 INFO - Options: 15:33:04 INFO - -h, --help show this help message and exit 15:33:04 INFO - -d DEST, --destination=DEST 15:33:04 INFO - Directory to install application into. [default: 15:33:04 INFO - "/builds/slave/test"] 15:33:04 INFO - --app=APP Application being installed. [default: firefox] 15:33:04 INFO - mkdir: /builds/slave/test/build/application 15:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:33:21 INFO - Reading from file tmpfile_stdout 15:33:21 INFO - Output received: 15:33:21 INFO - /builds/slave/test/build/application/firefox/firefox 15:33:21 INFO - Running post-action listener: _resource_record_post_action 15:33:21 INFO - ##### 15:33:21 INFO - ##### Finished install step (success) 15:33:21 INFO - ##### 15:33:21 INFO - ##### 15:33:21 INFO - ##### Running run-tests step. 15:33:21 INFO - ##### 15:33:21 INFO - Running pre-action listener: _resource_record_pre_action 15:33:21 INFO - Running main action method: run_tests 15:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:33:21 INFO - Python 2.7.3 15:33:21 INFO - Return code: 0 15:33:21 INFO - grabbing minidump binary from tooltool 15:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:21 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 0x16a1570>, '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 0x16a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:33:21 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 15:33:21 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 15:33:21 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 15:33:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:33:21 INFO - Return code: 0 15:33:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:33:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:33:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:33:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:33:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 15:33:21 INFO - Using env: {'DISPLAY': ':0', 15:33:21 INFO - 'HOME': '/home/cltbld', 15:33:21 INFO - 'LANG': 'en_US.UTF-8', 15:33:21 INFO - 'LANGUAGE': 'en_US:en', 15:33:21 INFO - 'LOGNAME': 'cltbld', 15:33:21 INFO - 'MAIL': '/var/mail/cltbld', 15:33:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:33:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:33:21 INFO - 'MOZ_NO_REMOTE': '1', 15:33:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:33:21 INFO - 'NO_EM_RESTART': '1', 15:33:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:33:21 INFO - 'PWD': '/builds/slave/test', 15:33:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:33:21 INFO - 'SHELL': '/bin/bash', 15:33:21 INFO - 'SHLVL': '1', 15:33:21 INFO - 'TERM': 'linux', 15:33:21 INFO - 'TMOUT': '86400', 15:33:21 INFO - 'USER': 'cltbld', 15:33:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808', 15:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:33:21 INFO - '_': '/tools/buildbot/bin/python'} 15:33:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:33:21 INFO - mozversion application_buildid: 20160629150227 15:33:21 INFO - mozversion application_changeset: b6ad395da0e5c99a4f4b6a5554d7df03a047393b 15:33:21 INFO - mozversion application_display_name: Nightly 15:33:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:33:21 INFO - mozversion application_name: Firefox 15:33:21 INFO - mozversion application_remotingname: firefox 15:33:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:33:21 INFO - mozversion application_vendor: Mozilla 15:33:21 INFO - mozversion application_version: 50.0a1 15:33:21 INFO - mozversion platform_buildid: 20160629150227 15:33:21 INFO - mozversion platform_changeset: b6ad395da0e5c99a4f4b6a5554d7df03a047393b 15:33:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:33:21 INFO - mozversion platform_version: 50.0a1 15:33:21 INFO - using testdate: 1467239601 15:33:21 INFO - actual date: 1467239601 15:33:21 INFO - starting webserver on 'localhost:47438' 15:33:21 INFO - SUITE-START | Running 2 tests 15:33:21 INFO - TEST-START | dromaeo_css 15:33:21 INFO - operating with platform_type : linux_ 15:33:21 INFO - Initialising browser for dromaeo_css test... 15:33:21 INFO - TEST-INFO | started process 22942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8XV4M/profile http://localhost:47438/getInfo.html) 15:33:26 INFO - PROCESS | 22942 | __metrics Screen width/height:1600/1200 15:33:26 INFO - PROCESS | 22942 | colorDepth:24 15:33:26 INFO - PROCESS | 22942 | Browser inner width/height: 1024/697 15:33:26 INFO - PROCESS | 22942 | __metrics 15:33:27 ERROR - PROCESS | 22942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:33:28 INFO - TEST-INFO | 22942: exit 0 15:33:28 INFO - Browser initialized. 15:33:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:33:28 INFO - TEST-INFO | started process 23061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN8XV4M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:40 INFO - PROCESS | 23061 | RSS: Main: 169455616 15:33:40 INFO - PROCESS | 23061 | 15:34:29 INFO - PROCESS | 23061 | 1467239669763 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] 15:36:42 INFO - PROCESS | 23061 | Cycle 1(1): loaded http://localhost:47438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47438/tests/dromaeo/cssquery-ext.html) 15:36:43 INFO - PROCESS | 23061 | RSS: Main: 170045440 15:36:43 INFO - PROCESS | 23061 | 15:39:45 INFO - PROCESS | 23061 | Cycle 1(1): loaded http://localhost:47438/tests/dromaeo/cssquery-ext.html (next: http://localhost:47438/tests/dromaeo/cssquery-jquery.html) 15:39:46 INFO - PROCESS | 23061 | RSS: Main: 169820160 15:39:46 INFO - PROCESS | 23061 | 15:42:47 INFO - PROCESS | 23061 | Cycle 1(1): loaded http://localhost:47438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47438/tests/dromaeo/cssquery-mootools.html) 15:42:48 INFO - PROCESS | 23061 | RSS: Main: 173355008 15:42:48 INFO - PROCESS | 23061 | 15:45:50 INFO - PROCESS | 23061 | Cycle 1(1): loaded http://localhost:47438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47438/tests/dromaeo/cssquery-prototype.html) 15:45:51 INFO - PROCESS | 23061 | RSS: Main: 168513536 15:45:51 INFO - PROCESS | 23061 | 15:48:53 INFO - PROCESS | 23061 | Cycle 1(1): loaded http://localhost:47438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47438/tests/dromaeo/cssquery-yui.html) 15:48:54 INFO - PROCESS | 23061 | RSS: Main: 170549248 15:48:54 INFO - PROCESS | 23061 | 15:51:56 INFO - PROCESS | 23061 | Cycle 1(1): loaded http://localhost:47438/tests/dromaeo/cssquery-yui.html (next: http://localhost:47438/tests/dromaeo/cssquery-dojo.html) 15:51:57 INFO - PROCESS | 23061 | RSS: Main: 171384832 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | __start_tp_report 15:51:57 INFO - PROCESS | 23061 | _x_x_mozilla_page_load 15:51:57 INFO - PROCESS | 23061 | _x_x_mozilla_page_load_details 15:51:57 INFO - PROCESS | 23061 | |i|pagename|runs| 15:51:57 INFO - PROCESS | 23061 | |0;dojo.html;2646.880890359934;2695.9460810783785;2700.2304343262176;2700.7569318761307;2715.1990162901943;4785.521447855217;4797;4848.539388758071;4895.265710143481;4946.084974279761;4762.499937506564;4849.927251091236;4882.829100981467;4891.682040667354;4897.142999975008;4432.202203603359;4464.174127786354;4530.773461326937;4551.590356867898;4563.406757121586;4234.640055595278;4518.954810451903;4530.592246697796;4594.2419500782335;4599.425071866017;4324.762138082404;4338.110687309094;4344.152890186383;4419.602235798793;4523.185826551203;4405.867823965286;4419.580139886705;4473.507914129443;4475.888102797424;4501.077279157797;4443.5112137665155;4454.2873140297725;4459.487158976727;4495.730256184606;4510.594046535794;4820.156472617278;4843.200871856139;4878.95121048792;4879.902401951941;4897.51024897511;5174.8097937474595;5213.635045546814;5217.113090774577;5237.266782650432;5285.286486324336;5053;5150;5229.823289759774;5229.973850130763;5270.4729527047375;4780.784864681098;4786.353842231289;4847.466778654345;4852.757362131879;4911.8280860169725;5255.816046438356;5322.547583455373;5329.467053294639;5332.68003919766;5334.67991920486;4962.776675049559;5099.286099946011;5101.51535604117;5125.461826508163;5162.148245539444;5112.36095488064;5256.39551451588;5286.312779338661;5293.602979776532;5323.095073837457;5118.923216151761;5119.1553393690365;5154.561862241751;5164.8192313268855;5165.793368265303;5033.043721692867;5078.568321692624;5139.691618502902;5143.8456846294675;5208.635395522353;4381.802818873159;4401.933970990438;4406.933895991563;4451.6883818133065;4460.241758900995;3816.103215744298;3829.4064420014943;3860;3861.826217820205;3903.765774053566;4401.493828209796;4463.196624607602;4480.39514665516;4516.322551617283;4524.027334123113;5281.841544753664;5334.359876814807;5334.626576139711;5343.251944727741;5343.946560534345;4505.504394516601;4555.225611645962;4557.202489564379;4562.201614717477;4599.885002874955;4556.11155824611;4646.395968524071;4654.115718013567;4710.105080034782;4801.447833499123;4864.927026094682;4874.293227481995;4922.483139270396;4931.901361972668;4982.526659967298;5234.424213336606;5261.921071184011;5262.079136151235;5270.657407268515;5274.604404669589;4792.7124372537755;4869.391326084239;4912.754362281943;4916.188828843201;4966.255061740768;5135.229715542699;5185.948140518546;5187.4553171916405;5190.195519694454;5252.2646829444675;5091.59267258611;5264.289320941624;5265.789368425373;5271.182966640177;5273.709945953009;4945.802167913387;5005.949940500548;5028.421731500778;5055.696658200372;5082.364704411949;5047.520485553867;5096.694198347963;5106.183010718267;5117.692938423706;5118.564921981524;4971.403431588088;4998.750062496933;5015.899682006412;5027.019731152536;5050.116229659869;5043.596512278936;5056.216286475602;5083.034223497523;5104.3619547556555;5121.641485096007;4978.626603004716;5005.149124648891;5006.949930500794;5015;5071.39143302806 15:51:57 INFO - PROCESS | 23061 | |1;ext.html;545.544641575318;581.1196038002425;596.6539407143857;603.4056454392422;648.4812150279776;33752.49371259433;38081.23837523255;38121.61878381219;38150.046248843755;38159.427608585895;38910;39379.606203937954;39431.21137577254;39448.408273875844;39487.21025579487;7706.344960678349;7829.06051273848;7840.764777056697;7904.170062143478;7906.446548741562;7729.574873381962;7805.4536182467255;7809.648565814524;7816.022997125359;7816.335611473031;7764.2235776422185;7810.375169986416;7825.6087195640275;7848.175941526115;7849.6075196240245;7769.572673502955;7783.883241751379;7801.063872335356;7814;7851.097123830747;7865.9606701966695;7884.053913530356;7913.604319784045;7920.445568810185;7943.761687149395;32066.198345041328;37677.811610942044;38088;38430;38579;2830.980846895116;3026.137550798034;3031.4694928387667;3646.124930016777;3860.4209368594657;28082.15753527377;30425;30596.235094122603;31105.844470777727;31283.530747038585;3241.1086951088405;3294.637589865113;3312.205070783019;3317.386283537529;3369.0566641340465;249906;256130;256409;257458;259242.70378648175;32784;33590.83204584011;33788.49317260243;57568;58323.87599302097;34675.4798678015;34694.13264668403;34724.30551388958;34860.30279394398;35019.4747078794;13796.862031379758;13941.721165576835;13964.092333998258;13975.440982360795;13992.510262140777;11468.426578671033;11504.137189710806;11507.654770356736;11522;11606.361650109326;8115.1479094694205;8140.104588495261;8148.5518296494265;8221.218984196492;8226.712065077694;3219.1952011997;3247.366763481146;3254.332861763333;3284.9343013139605;3328.833558322074;904.4889637354873;919.6229545886155;922.276013329533;956.4834989105944;974.9470571782458;27182.728172718416;28612.141635750962;28640.14079577616;28724.42551148965;28908.277293067422;954.379653225409;968.1770495079268;976.3995142987154;991.2268430623981;1082.2910993299402;15009.624759380884;15163.545093647208;15241.23793810305;15383.538493845203;15500.457483988006;726697;744119;744129;745545;746940;49364;49670.25494617584;49884.25173622399;50012.499875001515;50384;1201.5734414282979;1223.2477026628737;1228.0237211416945;1229.3975951783561;1231.0336385936996;27603.171904842886;28892.555372231724;28918.42163156767;29218.56172157377;29342.706572933996;41918.37122443227;42076.57923420849;42127.36808947929;42298.7885060585;42482.36276455794;288089;289821;291307;291990;341598;25009.87495062513;25454.363640909127;25470.363240919127;25656.102036428634;25769.226923192335;37413.81293093517;37539.81230093832;37652;37788.81105594454;41699;35218;35517.64482355143;35989.82005089958;36358.636413635526;36520.45219321659;36194.4570831443;36269.455958161176;36316.63683363238;36378.818105909304;36520.81739591285;31622.209444764067;36121.458178127876;36423;36453.81773091118;37387.43918841165;32901.34197315992;33934.83032584821;34517.13707157341;34737.478937815446;34776.82611586926;25467.617985730598;25630.487390251717;25798;25878.22365329043;26222.60666089972 15:51:57 INFO - PROCESS | 23061 | |2;jquery.html;366.42654246104826;369.7208607501336;372.48782923480206;379.8271786337217;387.4807757604809;16434.424795132174;17536.386226482075;18266.725999110025;18516.44450666479;18526.81473185268;17284.740728889075;17346.219420126094;17977.64044719105;18063.4580962571;18113.45659630213;5060.569851562613;5246.921296180561;5253.0544501989625;5264.657797243167;5304.443033481468;3671.4859919611276;4128;5150.974245128769;6194.256689197303;6352.301246862841;6271.655058971754;6272.749090036393;6276.68616569172;6288.30828608855;6306.49548036156;6100.328963813977;6174.413430724074;6218.595791273553;6229.813105606839;6238.4385405313515;5183.948160518422;5286;5468.72656367184;5470.234167216593;5471.905618876201;18781.24875004998;20004.399868003984;21613.567728645496;21737.2391966282;21892.343229702976;1973.4079776067122;1990.2735501541977;1996.4509759816021;2008.8694234874686;2209.5470428562107;9380.484073375961;9480.668176613854;9572.664956726481;11271;13565.59303220905;1800.1359347513137;1836.4215272189217;1860.153630098302;1872.4289091827125;1898.364048043907;70289.2971070293;72658;72968.27031729667;73607;73714.63142684252;9955.402675839472;10010.299279050541;10451;10475.738106547245;10587.100096491731;14012.299385030708;14025.368858401396;14057.929710351384;14143.85856141446;14151.43394264218;7017;7111.679974401164;7117.572945623279;7156.069710937649;7171.175314838756;6502.44729198014;6524.771632992823;6551.181102362205;6713.462922966151;6756.76351327711;4234.174336004449;4269.295566231599;4438.489573699066;4460.933086003713;4517.080240897605;1854.6290741851683;1873.8313551780404;1888.3768356442615;1911.5603411215498;1934.2456441987636;796.38678217772;867.4795122926193;867.696306292805;903.3089686389917;919.8206349761866;17061;17101.572460688334;17171.828281717273;17519.91240043817;17722.822771772375;831.2186544648011;869.9304055675531;892.5626443042992;946.9526523673788;948.9430634161835;9932.404055756677;9975;10060.597576097021;10083.798324033478;10083.848742268872;411403;411551;415544;438622;440773;46762.532374675815;51956.74021629943;79140;84142.15857841466;86650.30220920221;853.7396094191207;887.8002449448823;904.2675432899373;905.5472263868066;905.5698543192062;15978.946323055046;15994.200289985221;16269.59326016859;16576.75134873002;16924.984500929982;36657.45013824848;38067;39359.60640393559;39883.80058099691;40182.39726404165;54124;54841.451585483635;55358.72320638371;55405;55549.44450555443;7373.668184931798;7522.811929701582;7528.962355188189;7570.470067095251;7627.275408836152;8991.775205619912;11304.660860174208;11396.373199473777;11400;11448.828267575826;9491.620335186515;9495.762605934908;9712;9725.513724313614;9739.610415583298;10176.135028522658;10242.56604075445;10363.274570779973;10364;10567.418791966516;8851.336149788664;9369.390989585656;9534.713958581253;9691.321607487409;9817.31278810505;6740.056392105012;6946;7030.543014704028;7246.5289756165685;7381.557106573623;9464.053594640482;9541.809163816824;9667.274954378308;9686.370385924893;9712.70861874145 15:51:57 INFO - PROCESS | 23061 | |3;mootools.html;1348.3393137362696;1383.8131852199954;1452.2303179314968;1631.7492930914966;1670.1231853277036;6805.761798337059;7372.078490188726;7516.81207969801;7955.124936257007;7982.800429989253;7561.319481246686;7787.454878158531;7815.218478152182;7853.450258481908;7856.489328193664;2151.333086743111;2210.3810932938804;2211.1266049910278;2213.3581261434165;2218.279059305724;2163.3077415227135;2188.616992026397;2213.6900833883187;2217.523232505011;2228.765979572146;2175.695402643631;2184.7050648162535;2184.847060705751;2193.7586865444787;2213.18112298449;2146.64580344243;2149.1618268875072;2166.5775173841107;2169.425102347879;2170.370592528165;2098.2970704813906;2142.528643698384;2148.495103650641;2156.8813715245656;2158.330917415606;7805.063392392949;7810.531368117931;7862.803429914241;7866.763997080039;7874.685012599489;4402.691811573191;4552.8861778455475;4585.70192937458;4592.035672508777;4608.953910460886;2855.4146399988163;2861.957070643942;2932.252275669691;2945.6759756426777;2994.401119776032;920.9677661281889;950.6530116507494;965.0205041882494;967.5404183013083;984.0848011349442;10546.683599492104;10579.153667706565;10586.576536938514;10611.84082238767;10632.787344253149;3978.303796835542;4053.2906741320153;4186.769727665008;4210.073783767566;4215;9002;9023.368364214442;9046;9052.728418147335;9056.592453339616;4580.656450766206;4595.931061034087;4618.468876079227;4621.214393553104;4633.166030114612;3733.0667333166707;3994.900127496836;4136.73111247768;4222.071144348239;4231.428757117811;3598.5681718193982;3622.4385220290897;3691.7046636269033;3706.388445906395;3716.6655001050035;1152.9365884876245;1197.1859135787574;1200.8438902942737;1215.641385791176;1215.7082300247878;675.5170053411834;799.6481548118809;804.5092493578912;819.5574389829426;819.7868554175957;4837.371141751621;4964.503549645079;5062.569681577033;5066.442691303953;5104.515071068243;393.15079428434444;393.2018003452995;395.5194438756924;402.2196937940386;402.7120608764747;3251.544783730232;3329.450640644315;3333.1333853197857;3380.9012071077;3428.708559772447;9152.725418237464;9621.326507144573;9653.806923861483;9660.37207581505;9664.178544823628;9374.343795934356;9528.333016688764;9547.188488978376;9586.328956972944;9590.472524011246;7055.682494287769;7099.964500177466;7146.392556632641;7154.928450715531;7178.17450993132;4786.6410019248;4878.536439068194;4919.139150648693;4994.650374473752;5000.824971125993;8628.827423451621;8816.074312197383;8855.91144088551;8911.55442227899;8957.820843582962;8974;9038.819223615359;9087.954885188023;9102.226310763659;9178.173964342974;6072.1498990140535;6393.520485963479;6650.933490665031;6795.456363491007;6808;7519.812004699927;7524.623768811647;7531.171571127281;7594.6202689866395;7609.353204977418;6575.375339342755;6750;6799.796006119825;6828.863422731617;6857.794266172023;6732.427743641845;6754.5609535380045;6825.488088393489;6879.105716256855;6890.621015844176;5632.971835140962;5902.793402230901;5977.073553599199;6004.159417681441;6007.068904319837;4369.344598310279;4445.911081778411;4522.683412161117;4594.575681538734;4599.2871104978785;4418.160549495586;4466.776661166994;4489.19194544985;4572.771361431848;4599.954000459952 15:51:57 INFO - PROCESS | 23061 | |4;prototype.html;284.4978612748498;290.48149053938715;295.13819646631833;296.6469900818026;298.82220079052956;4944.664940466072;5018.598512119031;5144.279800827882;5185.481451854813;5217.713025783581;4998.825041123561;5025.170846810281;5030.465707959071;5049;5051.040302342552;3993.5423570396742;3995.900102497439;4050.898727531806;4054.9594504054876;4065.6137666921595;3949;4045.19096180765;4051.210014047262;4062.045419326456;4072.328065869128;3987.6211759882763;3989.9800500997453;3990.501187351581;3994.1412596291793;4002.6997975151835;3992.8402863885553;3996.760194388317;4012.4583181270445;4030;4034.959650403517;3420.4698271767916;3525.823708814549;3545.663161999606;3546.184377593168;3563.750537462379;5031.949680503221;5045.873853153664;5049.495050494921;5060.797568097271;5067.417247016567;4596.54034596541;4657.138429390574;4660.836870709542;4684.1334353144775;4686.882827929295;5237.607179461517;5319.696674314779;5332.32031909951;5351.6521426107565;5410.48600382963;3874.728768986172;3880.631340022693;3882.7282090253693;3887.1059656279213;3897.142628621699;5641.12562552805;5699.2306038684665;5707.800226992077;5720.2849643794525;5725.284339457609;3922.195949830278;3971.146203566247;3982.203559288154;3993.381025940984;4027.2146931348693;4050.432939388488;4053.1691003344245;4056.0936359910793;4057.9797101014306;4069.409935559327;4534.7052441591195;4590.862274131781;4612.3542704021465;4616.95383046172;4617.9307310389695;5148;5405.972970135203;5409;5422.213779002102;5450.236966824647;1324.198859689893;1363.9454421823214;1391.3947432866735;1392.046448182998;1405.8331584784605;951.543259235557;953.5470651440648;961.0629636104882;975.8731364922514;977.9926675524222;4620.792064357112;4630.282306242538;4645.0477652081245;4653.488116307203;4656.5110663379855;5449.509544140967;5504.862378440571;5596.664200148004;5609.382967873531;5612.719364031782;4524.502304746476;4640.883977900579;4652.371929789503;4672.742999135012;4728.503507131702;2601.973980260211;2607.8696065196664;2610.5040042392266;2626.500964816679;2645.642838216816;4594.264917613166;4600.700954437951;4604.309353596987;4617.515160908057;4624.861254162381;4757.738324392122;4913.631477639191;4961.181405068123;4970.8303364501235;5006.723285562159;4539.500654927955;4586.835083792173;4619.260918253063;4640.118377508263;4673.859784206344;4939.777710003131;4945.8021679132435;4964.702117872939;4964.751762411937;4971.900561988812;4430.737239886616;4766.285057241442;4768.737719425465;4795.736234506996;4803.255495398079;4518.164139634178;4603.700759450625;4614.623468913579;4635.397398338195;4652.767361631973;3633.836477358472;3650.6349365064343;3656.3601369759654;3660.5607327120915;3693.9076523087138;4839.540243676845;4861.854144375674;4966.776495057803;5255.78976840922;5318.787248510016;5378.650387724785;5391.865203369947;5393.7033463159905;5399.865003374947;5409.863928574886;5305.204219367126;5341.252224688625;5343.278657381204;5357.437469065848;5368.0406651572675;5098.490150985021;5199.48005199477;5274.604404669742;5279.604029697711;5312.309399778004;5415.918761218506;5434.402215756343;5471.644343117685;5479.917801233064;5479.945200547943;5292.708901010481;5302.469753024667;5303.496167864047;5315.521603055744;5363.0882749931825 15:51:57 INFO - PROCESS | 23061 | |5;yui.html;568.8208214412459;619.9597026193294;671.3722669304201;705.6295444891431;708.3483195460176;11514.942425287873;11807.645770626874;11947.880521194786;12024.579139730122;12028;11497.942510287457;11601.245919015279;11601.361925094116;11622.535098596067;11729.120315976294;766.9731559395423;795.4670370851543;797.1191833024511;797.972070977516;798.9360851131895;780.6292011294618;780.9258120478573;782;787.5943888897223;788.2629741191976;837.6105111123327;838.7483754873545;839.7900524868783;840.1346612988632;842.0821304777791;826.6817275349003;831.8003679116998;832.009908209229;834.3533761334953;835.4068611285934;612.6324205476723;615.756776073453;617.1206031405275;618.9226346706662;619.9101130336076;11938.522459101625;12010.939945300217;12034.81947770784;12048.337341446217;12085.758284834343;12060.638180854588;12324.630261092181;12641.431135598828;12756.61730148097;13019;9567.282453815991;9572.760680982961;9611.663591774324;9706.077922597342;9772.071653192936;3052.084374687585;3077.569140320357;3087.9691203087905;3096.5355196720448;3122.3911337289237;61684;62768;63579.36420635781;64043.67978160126;64087;9691.224702023963;9764.365316254421;9789;9840.015998400102;10043.899561004297;16094.19529023544;16633.417830376122;16701.832981670028;17472.65054698899;17533;6682.866342673119;6813.829654258584;6828.897566536407;6833.180018397824;7013.403860671798;3541.220931395089;3574.98212508941;3577.159367548624;3619.6561326673923;3769.98210483168;2789.3723912120017;2879.827210367385;2883.538633818579;2883.596296518489;2888.6100376448912;507.5229284472584;512.4670342843475;517.981870634526;518.1502336168686;522.7673685210121;476.36881132499576;538.9434109418534;550.4193076304457;551.503646717957;563.8477611044995;7416.555006699616;7496.925030749622;7578.280063393969;7686.654100565488;7868.921310786819;546.7621584610707;550.5017958747341;551.0824477245421;553.8037838269319;566.6684989281316;3619.5656521217625;3631.673149416565;3673;3705.8517659293325;3710.5547334320054;51528.74235628798;51735.48264517307;51764.48235517672;84934.72597911036;92370.53814731017;48904.7554762231;80912.19087809046;82048;83154.58422707969;84379.57810211032;43733.56266437359;45892.77053614777;73964.63017684985;74207.62896185592;74430;6744.763933262312;6945.583265003914;6971.442284617117;7041.119860017498;7113.644317784194;44554;44666.10667786561;44835;45126.54873451355;46165.53834461747;50129.74935125301;60800.69599651973;60909;61025;61534.69232653808;9397.906020939703;9703.369280996994;9740.366876153028;9789.412635241908;10058.748531286776;10917.945410273216;10958.890411096107;10981.121510279;11002.614908478165;11014.339139651647;9228.769280768034;9287.907120928705;9330.626774928927;9504.667336643184;9510.429374237568;10071.597136114766;10230.28388012832;10278.229132814919;10446.05985461312;10863.511141998471;9807.362521436084;9895;10068.69793906184;10078.899211007796;10146.898531014891;8490.448120872123;8527.888594295762;8573.142685731627;8627.6980305689;8718.215360617574;8473.322134229371;8676.305895528216;8873.778155546162;8925.866112008454;9078.09219078087 15:51:57 INFO - PROCESS | 23061 | __end_tp_report 15:51:57 INFO - PROCESS | 23061 | __start_cc_report 15:51:57 INFO - PROCESS | 23061 | _x_x_mozilla_cycle_collect,375 15:51:57 INFO - PROCESS | 23061 | __end_cc_report 15:51:57 INFO - PROCESS | 23061 | __startTimestamp1467240717148__endTimestamp 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | ------- Summary: start ------- 15:51:57 INFO - PROCESS | 23061 | Number of tests: 6 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | [#0] dojo.html Cycles:165 Average:4811.91 Median:4945.80 stddev:512.07 (10.4%) stddev-sans-first:484.66 15:51:57 INFO - PROCESS | 23061 | Values: 2646.9 2695.9 2700.2 2700.8 2715.2 4785.5 4797.0 4848.5 4895.3 4946.1 4762.5 4849.9 4882.8 4891.7 4897.1 4432.2 4464.2 4530.8 4551.6 4563.4 4234.6 4519.0 4530.6 4594.2 4599.4 4324.8 4338.1 4344.2 4419.6 4523.2 4405.9 4419.6 4473.5 4475.9 4501.1 4443.5 4454.3 4459.5 4495.7 4510.6 4820.2 4843.2 4879.0 4879.9 4897.5 5174.8 5213.6 5217.1 5237.3 5285.3 5053.0 5150.0 5229.8 5230.0 5270.5 4780.8 4786.4 4847.5 4852.8 4911.8 5255.8 5322.5 5329.5 5332.7 5334.7 4962.8 5099.3 5101.5 5125.5 5162.1 5112.4 5256.4 5286.3 5293.6 5323.1 5118.9 5119.2 5154.6 5164.8 5165.8 5033.0 5078.6 5139.7 5143.8 5208.6 4381.8 4401.9 4406.9 4451.7 4460.2 3816.1 3829.4 3860.0 3861.8 3903.8 4401.5 4463.2 4480.4 4516.3 4524.0 5281.8 5334.4 5334.6 5343.3 5343.9 4505.5 4555.2 4557.2 4562.2 4599.9 4556.1 4646.4 4654.1 4710.1 4801.4 4864.9 4874.3 4922.5 4931.9 4982.5 5234.4 5261.9 5262.1 5270.7 5274.6 4792.7 4869.4 4912.8 4916.2 4966.3 5135.2 5185.9 5187.5 5190.2 5252.3 5091.6 5264.3 5265.8 5271.2 5273.7 4945.8 5005.9 5028.4 5055.7 5082.4 5047.5 5096.7 5106.2 5117.7 5118.6 4971.4 4998.8 5015.9 5027.0 5050.1 5043.6 5056.2 5083.0 5104.4 5121.6 4978.6 5005.1 5006.9 5015.0 5071.4 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | [#1] ext.html Cycles:180 Average:55620.99 Median:36293.05 stddev:131373.47 (362.0%) stddev-sans-first:131676.92 15:51:57 INFO - PROCESS | 23061 | Values: 545.5 581.1 596.7 603.4 648.5 33752.5 38081.2 38121.6 38150.0 38159.4 38910.0 39379.6 39431.2 39448.4 39487.2 7706.3 7829.1 7840.8 7904.2 7906.4 7729.6 7805.5 7809.6 7816.0 7816.3 7764.2 7810.4 7825.6 7848.2 7849.6 7769.6 7783.9 7801.1 7814.0 7851.1 7866.0 7884.1 7913.6 7920.4 7943.8 32066.2 37677.8 38088.0 38430.0 38579.0 2831.0 3026.1 3031.5 3646.1 3860.4 28082.2 30425.0 30596.2 31105.8 31283.5 3241.1 3294.6 3312.2 3317.4 3369.1 249906.0 256130.0 256409.0 257458.0 259242.7 32784.0 33590.8 33788.5 57568.0 58323.9 34675.5 34694.1 34724.3 34860.3 35019.5 13796.9 13941.7 13964.1 13975.4 13992.5 11468.4 11504.1 11507.7 11522.0 11606.4 8115.1 8140.1 8148.6 8221.2 8226.7 3219.2 3247.4 3254.3 3284.9 3328.8 904.5 919.6 922.3 956.5 974.9 27182.7 28612.1 28640.1 28724.4 28908.3 954.4 968.2 976.4 991.2 1082.3 15009.6 15163.5 15241.2 15383.5 15500.5 726697.0 744119.0 744129.0 745545.0 746940.0 49364.0 49670.3 49884.3 50012.5 50384.0 1201.6 1223.2 1228.0 1229.4 1231.0 27603.2 28892.6 28918.4 29218.6 29342.7 41918.4 42076.6 42127.4 42298.8 42482.4 288089.0 289821.0 291307.0 291990.0 341598.0 25009.9 25454.4 25470.4 25656.1 25769.2 37413.8 37539.8 37652.0 37788.8 41699.0 35218.0 35517.6 35989.8 36358.6 36520.5 36194.5 36269.5 36316.6 36378.8 36520.8 31622.2 36121.5 36423.0 36453.8 37387.4 32901.3 33934.8 34517.1 34737.5 34776.8 25467.6 25630.5 25798.0 25878.2 26222.6 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | [#2] jquery.html Cycles:180 Average:25406.34 Median:5249.99 stddev:69792.03 (1329.4%) stddev-sans-first:69962.49 15:51:57 INFO - PROCESS | 23061 | Values: 366.4 369.7 372.5 379.8 387.5 16434.4 17536.4 18266.7 18516.4 18526.8 17284.7 17346.2 17977.6 18063.5 18113.5 5060.6 5246.9 5253.1 5264.7 5304.4 3671.5 4128.0 5151.0 6194.3 6352.3 6271.7 6272.7 6276.7 6288.3 6306.5 6100.3 6174.4 6218.6 6229.8 6238.4 5183.9 5286.0 5468.7 5470.2 5471.9 18781.2 20004.4 21613.6 21737.2 21892.3 1973.4 1990.3 1996.5 2008.9 2209.5 9380.5 9480.7 9572.7 11271.0 13565.6 1800.1 1836.4 1860.2 1872.4 1898.4 70289.3 72658.0 72968.3 73607.0 73714.6 9955.4 10010.3 10451.0 10475.7 10587.1 14012.3 14025.4 14057.9 14143.9 14151.4 7017.0 7111.7 7117.6 7156.1 7171.2 6502.4 6524.8 6551.2 6713.5 6756.8 4234.2 4269.3 4438.5 4460.9 4517.1 1854.6 1873.8 1888.4 1911.6 1934.2 796.4 867.5 867.7 903.3 919.8 17061.0 17101.6 17171.8 17519.9 17722.8 831.2 869.9 892.6 947.0 948.9 9932.4 9975.0 10060.6 10083.8 10083.8 411403.0 411551.0 415544.0 438622.0 440773.0 46762.5 51956.7 79140.0 84142.2 86650.3 853.7 887.8 904.3 905.5 905.6 15978.9 15994.2 16269.6 16576.8 16925.0 36657.5 38067.0 39359.6 39883.8 40182.4 54124.0 54841.5 55358.7 55405.0 55549.4 7373.7 7522.8 7529.0 7570.5 7627.3 8991.8 11304.7 11396.4 11400.0 11448.8 9491.6 9495.8 9712.0 9725.5 9739.6 10176.1 10242.6 10363.3 10364.0 10567.4 8851.3 9369.4 9534.7 9691.3 9817.3 6740.1 6946.0 7030.5 7246.5 7381.6 9464.1 9541.8 9667.3 9686.4 9712.7 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | [#3] mootools.html Cycles:180 Average:5067.12 Median:4812.01 stddev:2877.30 (59.8%) stddev-sans-first:2871.80 15:51:57 INFO - PROCESS | 23061 | Values: 1348.3 1383.8 1452.2 1631.7 1670.1 6805.8 7372.1 7516.8 7955.1 7982.8 7561.3 7787.5 7815.2 7853.5 7856.5 2151.3 2210.4 2211.1 2213.4 2218.3 2163.3 2188.6 2213.7 2217.5 2228.8 2175.7 2184.7 2184.8 2193.8 2213.2 2146.6 2149.2 2166.6 2169.4 2170.4 2098.3 2142.5 2148.5 2156.9 2158.3 7805.1 7810.5 7862.8 7866.8 7874.7 4402.7 4552.9 4585.7 4592.0 4609.0 2855.4 2862.0 2932.3 2945.7 2994.4 921.0 950.7 965.0 967.5 984.1 10546.7 10579.2 10586.6 10611.8 10632.8 3978.3 4053.3 4186.8 4210.1 4215.0 9002.0 9023.4 9046.0 9052.7 9056.6 4580.7 4595.9 4618.5 4621.2 4633.2 3733.1 3994.9 4136.7 4222.1 4231.4 3598.6 3622.4 3691.7 3706.4 3716.7 1152.9 1197.2 1200.8 1215.6 1215.7 675.5 799.6 804.5 819.6 819.8 4837.4 4964.5 5062.6 5066.4 5104.5 393.2 393.2 395.5 402.2 402.7 3251.5 3329.5 3333.1 3380.9 3428.7 9152.7 9621.3 9653.8 9660.4 9664.2 9374.3 9528.3 9547.2 9586.3 9590.5 7055.7 7100.0 7146.4 7154.9 7178.2 4786.6 4878.5 4919.1 4994.7 5000.8 8628.8 8816.1 8855.9 8911.6 8957.8 8974.0 9038.8 9088.0 9102.2 9178.2 6072.1 6393.5 6650.9 6795.5 6808.0 7519.8 7524.6 7531.2 7594.6 7609.4 6575.4 6750.0 6799.8 6828.9 6857.8 6732.4 6754.6 6825.5 6879.1 6890.6 5633.0 5902.8 5977.1 6004.2 6007.1 4369.3 4445.9 4522.7 4594.6 4599.3 4418.2 4466.8 4489.2 4572.8 4600.0 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | [#4] prototype.html Cycles:180 Average:4341.85 Median:4666.79 stddev:1246.02 (26.7%) stddev-sans-first:1211.73 15:51:57 INFO - PROCESS | 23061 | Values: 284.5 290.5 295.1 296.6 298.8 4944.7 5018.6 5144.3 5185.5 5217.7 4998.8 5025.2 5030.5 5049.0 5051.0 3993.5 3995.9 4050.9 4055.0 4065.6 3949.0 4045.2 4051.2 4062.0 4072.3 3987.6 3990.0 3990.5 3994.1 4002.7 3992.8 3996.8 4012.5 4030.0 4035.0 3420.5 3525.8 3545.7 3546.2 3563.8 5031.9 5045.9 5049.5 5060.8 5067.4 4596.5 4657.1 4660.8 4684.1 4686.9 5237.6 5319.7 5332.3 5351.7 5410.5 3874.7 3880.6 3882.7 3887.1 3897.1 5641.1 5699.2 5707.8 5720.3 5725.3 3922.2 3971.1 3982.2 3993.4 4027.2 4050.4 4053.2 4056.1 4058.0 4069.4 4534.7 4590.9 4612.4 4617.0 4617.9 5148.0 5406.0 5409.0 5422.2 5450.2 1324.2 1363.9 1391.4 1392.0 1405.8 951.5 953.5 961.1 975.9 978.0 4620.8 4630.3 4645.0 4653.5 4656.5 5449.5 5504.9 5596.7 5609.4 5612.7 4524.5 4640.9 4652.4 4672.7 4728.5 2602.0 2607.9 2610.5 2626.5 2645.6 4594.3 4600.7 4604.3 4617.5 4624.9 4757.7 4913.6 4961.2 4970.8 5006.7 4539.5 4586.8 4619.3 4640.1 4673.9 4939.8 4945.8 4964.7 4964.8 4971.9 4430.7 4766.3 4768.7 4795.7 4803.3 4518.2 4603.7 4614.6 4635.4 4652.8 3633.8 3650.6 3656.4 3660.6 3693.9 4839.5 4861.9 4966.8 5255.8 5318.8 5378.7 5391.9 5393.7 5399.9 5409.9 5305.2 5341.3 5343.3 5357.4 5368.0 5098.5 5199.5 5274.6 5279.6 5312.3 5415.9 5434.4 5471.6 5479.9 5479.9 5292.7 5302.5 5303.5 5315.5 5363.1 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - PROCESS | 23061 | [#5] yui.html Cycles:180 Average:15694.89 Median:30818.82 stddev:22024.51 (71.5%) stddev-sans-first:22057.01 15:51:57 INFO - PROCESS | 23061 | Values: 568.8 620.0 671.4 705.6 708.3 11514.9 11807.6 11947.9 12024.6 12028.0 11497.9 11601.2 11601.4 11622.5 11729.1 767.0 795.5 797.1 798.0 798.9 780.6 780.9 782.0 787.6 788.3 837.6 838.7 839.8 840.1 842.1 826.7 831.8 832.0 834.4 835.4 612.6 615.8 617.1 618.9 619.9 11938.5 12010.9 12034.8 12048.3 12085.8 12060.6 12324.6 12641.4 12756.6 13019.0 9567.3 9572.8 9611.7 9706.1 9772.1 3052.1 3077.6 3088.0 3096.5 3122.4 61684.0 62768.0 63579.4 64043.7 64087.0 9691.2 9764.4 9789.0 9840.0 10043.9 16094.2 16633.4 16701.8 17472.7 17533.0 6682.9 6813.8 6828.9 6833.2 7013.4 3541.2 3575.0 3577.2 3619.7 3770.0 2789.4 2879.8 2883.5 2883.6 2888.6 507.5 512.5 518.0 518.2 522.8 476.4 538.9 550.4 551.5 563.8 7416.6 7496.9 7578.3 7686.7 7868.9 546.8 550.5 551.1 553.8 566.7 3619.6 3631.7 3673.0 3705.9 3710.6 51528.7 51735.5 51764.5 84934.7 92370.5 48904.8 80912.2 82048.0 83154.6 84379.6 43733.6 45892.8 73964.6 74207.6 74430.0 6744.8 6945.6 6971.4 7041.1 7113.6 44554.0 44666.1 44835.0 45126.5 46165.5 50129.7 60800.7 60909.0 61025.0 61534.7 9397.9 9703.4 9740.4 9789.4 10058.7 10917.9 10958.9 10981.1 11002.6 11014.3 9228.8 9287.9 9330.6 9504.7 9510.4 10071.6 10230.3 10278.2 10446.1 10863.5 9807.4 9895.0 10068.7 10078.9 10146.9 8490.4 8527.9 8573.1 8627.7 8718.2 8473.3 8676.3 8873.8 8925.9 9078.1 15:51:57 INFO - PROCESS | 23061 | -------- Summary: end -------- 15:51:57 INFO - PROCESS | 23061 | 15:51:57 INFO - TEST-INFO | 23061: exit 0 15:51:57 INFO - TEST-OK | dromaeo_css | took 1116701ms 15:51:57 INFO - TEST-START | kraken 15:51:57 INFO - operating with platform_type : linux_ 15:51:57 INFO - Initialising browser for kraken test... 15:51:57 INFO - TEST-INFO | started process 23306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYSWIVh/profile http://localhost:47438/getInfo.html) 15:52:02 INFO - PROCESS | 23306 | __metrics Screen width/height:1600/1200 15:52:02 INFO - PROCESS | 23306 | colorDepth:24 15:52:02 INFO - PROCESS | 23306 | Browser inner width/height: 1024/697 15:52:02 INFO - PROCESS | 23306 | __metrics 15:52:03 ERROR - PROCESS | 23306 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:52:04 INFO - TEST-INFO | 23306: exit 0 15:52:04 INFO - Browser initialized. 15:52:04 INFO - Running cycle 1/1 for kraken test... 15:52:04 INFO - TEST-INFO | started process 23425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYSWIVh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:16 INFO - PROCESS | 23425 | RSS: Main: 169574400 15:52:16 INFO - PROCESS | 23425 | 15:52:19 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47438/tests/kraken/driver.html?testName=audio-beat-detection) 15:52:20 INFO - PROCESS | 23425 | RSS: Main: 174379008 15:52:20 INFO - PROCESS | 23425 | 15:52:22 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47438/tests/kraken/driver.html?testName=audio-dft) 15:52:23 INFO - PROCESS | 23425 | RSS: Main: 175222784 15:52:23 INFO - PROCESS | 23425 | 15:52:26 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47438/tests/kraken/driver.html?testName=audio-fft) 15:52:27 INFO - PROCESS | 23425 | RSS: Main: 169852928 15:52:27 INFO - PROCESS | 23425 | 15:52:29 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47438/tests/kraken/driver.html?testName=audio-oscillator) 15:52:29 INFO - PROCESS | 23425 | RSS: Main: 170143744 15:52:29 INFO - PROCESS | 23425 | 15:52:32 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:52:32 INFO - PROCESS | 23425 | RSS: Main: 170442752 15:52:32 INFO - PROCESS | 23425 | 15:52:36 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47438/tests/kraken/driver.html?testName=imaging-darkroom) 15:52:36 INFO - PROCESS | 23425 | RSS: Main: 170659840 15:52:36 INFO - PROCESS | 23425 | 15:52:40 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47438/tests/kraken/driver.html?testName=imaging-desaturate) 15:52:40 INFO - PROCESS | 23425 | RSS: Main: 168239104 15:52:40 INFO - PROCESS | 23425 | 15:52:43 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47438/tests/kraken/driver.html?testName=json-parse-financial) 15:52:44 INFO - PROCESS | 23425 | RSS: Main: 169689088 15:52:44 INFO - PROCESS | 23425 | 15:52:46 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:52:46 INFO - PROCESS | 23425 | RSS: Main: 169914368 15:52:46 INFO - PROCESS | 23425 | 15:52:48 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:52:49 INFO - PROCESS | 23425 | RSS: Main: 170606592 15:52:49 INFO - PROCESS | 23425 | 15:52:51 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:52:52 INFO - PROCESS | 23425 | RSS: Main: 170905600 15:52:52 INFO - PROCESS | 23425 | 15:52:54 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:52:55 INFO - PROCESS | 23425 | RSS: Main: 170860544 15:52:55 INFO - PROCESS | 23425 | 15:52:58 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:52:59 INFO - PROCESS | 23425 | RSS: Main: 170524672 15:52:59 INFO - PROCESS | 23425 | 15:53:00 INFO - PROCESS | 23425 | Cycle 1(1): loaded http://localhost:47438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47438/tests/kraken/driver.html?testName=ai-astar) 15:53:01 INFO - PROCESS | 23425 | RSS: Main: 171671552 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | __start_tp_report 15:53:01 INFO - PROCESS | 23425 | _x_x_mozilla_page_load 15:53:01 INFO - PROCESS | 23425 | _x_x_mozilla_page_load_details 15:53:01 INFO - PROCESS | 23425 | |i|pagename|runs| 15:53:01 INFO - PROCESS | 23425 | |0;ai-astar;106;116;108;116;114;116;117;114;114;114 15:53:01 INFO - PROCESS | 23425 | |1;audio-beat-detection;163;124;152;181;125;158;158;127;200;125 15:53:01 INFO - PROCESS | 23425 | |2;audio-dft;163;162;165;172;168;163;162;169;163;163 15:53:01 INFO - PROCESS | 23425 | |3;audio-fft;78;75;75;156;76;76;76;75;156;77 15:53:01 INFO - PROCESS | 23425 | |4;audio-oscillator;87;86;145;86;87;87;142;86;87;135 15:53:01 INFO - PROCESS | 23425 | |5;imaging-gaussian-blur;117;117;117;118;118;118;118;117;119;119 15:53:01 INFO - PROCESS | 23425 | |6;imaging-darkroom;149;148;147;148;148;147;147;149;147;147 15:53:01 INFO - PROCESS | 23425 | |7;imaging-desaturate;96;95;95;95;95;97;96;95;95;95 15:53:01 INFO - PROCESS | 23425 | |8;json-parse-financial;64;65;64;64;66;64;64;65;71;64 15:53:01 INFO - PROCESS | 23425 | |9;json-stringify-tinderbox;64;64;64;65;65;64;65;64;65;64 15:53:01 INFO - PROCESS | 23425 | |10;stanford-crypto-aes;79;84;86;78;78;79;77;79;82;79 15:53:01 INFO - PROCESS | 23425 | |11;stanford-crypto-ccm;137;137;130;145;131;131;130;142;171;135 15:53:01 INFO - PROCESS | 23425 | |12;stanford-crypto-pbkdf2;169;165;170;164;173;169;166;162;167;163 15:53:01 INFO - PROCESS | 23425 | |13;stanford-crypto-sha256-iterative;72;69;69;69;68;67;68;67;71;66 15:53:01 INFO - PROCESS | 23425 | __end_tp_report 15:53:01 INFO - PROCESS | 23425 | __start_cc_report 15:53:01 INFO - PROCESS | 23425 | _x_x_mozilla_cycle_collect,990 15:53:01 INFO - PROCESS | 23425 | __end_cc_report 15:53:01 INFO - PROCESS | 23425 | __startTimestamp1467240781039__endTimestamp 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | ------- Summary: start ------- 15:53:01 INFO - PROCESS | 23425 | Number of tests: 14 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.63 (3.2%) stddev-sans-first:2.65 15:53:01 INFO - PROCESS | 23425 | Values: 106.0 116.0 108.0 116.0 114.0 116.0 117.0 114.0 114.0 114.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:158.00 stddev:26.25 (16.6%) stddev-sans-first:27.50 15:53:01 INFO - PROCESS | 23425 | Values: 163.0 124.0 152.0 181.0 125.0 158.0 158.0 127.0 200.0 125.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:3.46 (2.1%) stddev-sans-first:3.60 15:53:01 INFO - PROCESS | 23425 | Values: 163.0 162.0 165.0 172.0 168.0 163.0 162.0 169.0 163.0 163.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#3] audio-fft Cycles:10 Average:92.00 Median:76.00 stddev:33.74 (44.4%) stddev-sans-first:35.41 15:53:01 INFO - PROCESS | 23425 | Values: 78.0 75.0 75.0 156.0 76.0 76.0 76.0 75.0 156.0 77.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:86.50 stddev:26.25 (30.3%) stddev-sans-first:27.21 15:53:01 INFO - PROCESS | 23425 | Values: 87.0 86.0 145.0 86.0 87.0 87.0 142.0 86.0 87.0 135.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 15:53:01 INFO - PROCESS | 23425 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 119.0 119.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 15:53:01 INFO - PROCESS | 23425 | Values: 149.0 148.0 147.0 148.0 148.0 147.0 147.0 149.0 147.0 147.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 15:53:01 INFO - PROCESS | 23425 | Values: 96.0 95.0 95.0 95.0 95.0 97.0 96.0 95.0 95.0 95.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.50 stddev:2.18 (3.4%) stddev-sans-first:2.28 15:53:01 INFO - PROCESS | 23425 | Values: 64.0 65.0 64.0 64.0 66.0 64.0 64.0 65.0 71.0 64.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 15:53:01 INFO - PROCESS | 23425 | Values: 64.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 65.0 64.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:2.92 (3.7%) stddev-sans-first:3.07 15:53:01 INFO - PROCESS | 23425 | Values: 79.0 84.0 86.0 78.0 78.0 79.0 77.0 79.0 82.0 79.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:137.00 stddev:12.40 (9.0%) stddev-sans-first:13.13 15:53:01 INFO - PROCESS | 23425 | Values: 137.0 137.0 130.0 145.0 131.0 131.0 130.0 142.0 171.0 135.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:168.00 stddev:3.46 (2.1%) stddev-sans-first:3.57 15:53:01 INFO - PROCESS | 23425 | Values: 169.0 165.0 170.0 164.0 173.0 169.0 166.0 162.0 167.0 163.0 15:53:01 INFO - PROCESS | 23425 | 15:53:01 INFO - PROCESS | 23425 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.84 (2.7%) stddev-sans-first:1.48 15:53:01 INFO - PROCESS | 23425 | Values: 72.0 69.0 69.0 69.0 68.0 67.0 68.0 67.0 71.0 66.0 15:53:01 INFO - PROCESS | 23425 | -------- Summary: end -------- 15:53:01 INFO - PROCESS | 23425 | 15:53:02 INFO - TEST-INFO | 23425: exit 0 15:53:02 INFO - TEST-OK | kraken | took 64170ms 15:53:02 INFO - SUITE-END | took 1180s 15:53:02 INFO - Completed test suite (00:19:40) 15:53:02 INFO - javascript benchmark 15:53:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6332.864045384804, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.880890359934, 2695.9460810783785, 2700.2304343262176, 2700.7569318761307, 2715.1990162901943, 4785.521447855217, 4797.0, 4848.539388758071, 4895.265710143481, 4946.084974279761, 4762.499937506564, 4849.927251091236, 4882.829100981467, 4891.682040667354, 4897.142999975008, 4432.202203603359, 4464.174127786354, 4530.773461326937, 4551.590356867898, 4563.406757121586, 4234.640055595278, 4518.954810451903, 4530.592246697796, 4594.2419500782335, 4599.425071866017, 4324.762138082404, 4338.110687309094, 4344.152890186383, 4419.602235798793, 4523.185826551203, 4405.867823965286, 4419.580139886705, 4473.507914129443, 4475.888102797424, 4501.077279157797, 4443.5112137665155, 4454.2873140297725, 4459.487158976727, 4495.730256184606, 4510.594046535794, 4820.156472617278, 4843.200871856139, 4878.95121048792, 4879.902401951941, 4897.51024897511, 5174.8097937474595, 5213.635045546814, 5217.113090774577, 5237.266782650432, 5285.286486324336, 5053.0, 5150.0, 5229.823289759774, 5229.973850130763, 5270.4729527047375, 4780.784864681098, 4786.353842231289, 4847.466778654345, 4852.757362131879, 4911.8280860169725, 5255.816046438356, 5322.547583455373, 5329.467053294639, 5332.68003919766, 5334.67991920486, 4962.776675049559, 5099.286099946011, 5101.51535604117, 5125.461826508163, 5162.148245539444, 5112.36095488064, 5256.39551451588, 5286.312779338661, 5293.602979776532, 5323.095073837457, 5118.923216151761, 5119.1553393690365, 5154.561862241751, 5164.8192313268855, 5165.793368265303, 5033.043721692867, 5078.568321692624, 5139.691618502902, 5143.8456846294675, 5208.635395522353, 4381.802818873159, 4401.933970990438, 4406.933895991563, 4451.6883818133065, 4460.241758900995, 3816.103215744298, 3829.4064420014943, 3860.0, 3861.826217820205, 3903.765774053566, 4401.493828209796, 4463.196624607602, 4480.39514665516, 4516.322551617283, 4524.027334123113, 5281.841544753664, 5334.359876814807, 5334.626576139711, 5343.251944727741, 5343.946560534345, 4505.504394516601, 4555.225611645962, 4557.202489564379, 4562.201614717477, 4599.885002874955, 4556.11155824611, 4646.395968524071, 4654.115718013567, 4710.105080034782, 4801.447833499123, 4864.927026094682, 4874.293227481995, 4922.483139270396, 4931.901361972668, 4982.526659967298, 5234.424213336606, 5261.921071184011, 5262.079136151235, 5270.657407268515, 5274.604404669589, 4792.7124372537755, 4869.391326084239, 4912.754362281943, 4916.188828843201, 4966.255061740768, 5135.229715542699, 5185.948140518546, 5187.4553171916405, 5190.195519694454, 5252.2646829444675, 5091.59267258611, 5264.289320941624, 5265.789368425373, 5271.182966640177, 5273.709945953009, 4945.802167913387, 5005.949940500548, 5028.421731500778, 5055.696658200372, 5082.364704411949, 5047.520485553867, 5096.694198347963, 5106.183010718267, 5117.692938423706, 5118.564921981524, 4971.403431588088, 4998.750062496933, 5015.899682006412, 5027.019731152536, 5050.116229659869, 5043.596512278936, 5056.216286475602, 5083.034223497523, 5104.3619547556555, 5121.641485096007, 4978.626603004716, 5005.149124648891, 5006.949930500794, 5015.0, 5071.39143302806], "value": 4778.669512471177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.544641575318, 581.1196038002425, 596.6539407143857, 603.4056454392422, 648.4812150279776, 33752.49371259433, 38081.23837523255, 38121.61878381219, 38150.046248843755, 38159.427608585895, 38910.0, 39379.606203937954, 39431.21137577254, 39448.408273875844, 39487.21025579487, 7706.344960678349, 7829.06051273848, 7840.764777056697, 7904.170062143478, 7906.446548741562, 7729.574873381962, 7805.4536182467255, 7809.648565814524, 7816.022997125359, 7816.335611473031, 7764.2235776422185, 7810.375169986416, 7825.6087195640275, 7848.175941526115, 7849.6075196240245, 7769.572673502955, 7783.883241751379, 7801.063872335356, 7814.0, 7851.097123830747, 7865.9606701966695, 7884.053913530356, 7913.604319784045, 7920.445568810185, 7943.761687149395, 32066.198345041328, 37677.811610942044, 38088.0, 38430.0, 38579.0, 2830.980846895116, 3026.137550798034, 3031.4694928387667, 3646.124930016777, 3860.4209368594657, 28082.15753527377, 30425.0, 30596.235094122603, 31105.844470777727, 31283.530747038585, 3241.1086951088405, 3294.637589865113, 3312.205070783019, 3317.386283537529, 3369.0566641340465, 249906.0, 256130.0, 256409.0, 257458.0, 259242.70378648175, 32784.0, 33590.83204584011, 33788.49317260243, 57568.0, 58323.87599302097, 34675.4798678015, 34694.13264668403, 34724.30551388958, 34860.30279394398, 35019.4747078794, 13796.862031379758, 13941.721165576835, 13964.092333998258, 13975.440982360795, 13992.510262140777, 11468.426578671033, 11504.137189710806, 11507.654770356736, 11522.0, 11606.361650109326, 8115.1479094694205, 8140.104588495261, 8148.5518296494265, 8221.218984196492, 8226.712065077694, 3219.1952011997, 3247.366763481146, 3254.332861763333, 3284.9343013139605, 3328.833558322074, 904.4889637354873, 919.6229545886155, 922.276013329533, 956.4834989105944, 974.9470571782458, 27182.728172718416, 28612.141635750962, 28640.14079577616, 28724.42551148965, 28908.277293067422, 954.379653225409, 968.1770495079268, 976.3995142987154, 991.2268430623981, 1082.2910993299402, 15009.624759380884, 15163.545093647208, 15241.23793810305, 15383.538493845203, 15500.457483988006, 726697.0, 744119.0, 744129.0, 745545.0, 746940.0, 49364.0, 49670.25494617584, 49884.25173622399, 50012.499875001515, 50384.0, 1201.5734414282979, 1223.2477026628737, 1228.0237211416945, 1229.3975951783561, 1231.0336385936996, 27603.171904842886, 28892.555372231724, 28918.42163156767, 29218.56172157377, 29342.706572933996, 41918.37122443227, 42076.57923420849, 42127.36808947929, 42298.7885060585, 42482.36276455794, 288089.0, 289821.0, 291307.0, 291990.0, 341598.0, 25009.87495062513, 25454.363640909127, 25470.363240919127, 25656.102036428634, 25769.226923192335, 37413.81293093517, 37539.81230093832, 37652.0, 37788.81105594454, 41699.0, 35218.0, 35517.64482355143, 35989.82005089958, 36358.636413635526, 36520.45219321659, 36194.4570831443, 36269.455958161176, 36316.63683363238, 36378.818105909304, 36520.81739591285, 31622.209444764067, 36121.458178127876, 36423.0, 36453.81773091118, 37387.43918841165, 32901.34197315992, 33934.83032584821, 34517.13707157341, 34737.478937815446, 34776.82611586926, 25467.617985730598, 25630.487390251717, 25798.0, 25878.22365329043, 26222.60666089972], "value": 16830.818261189626, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.42654246104826, 369.7208607501336, 372.48782923480206, 379.8271786337217, 387.4807757604809, 16434.424795132174, 17536.386226482075, 18266.725999110025, 18516.44450666479, 18526.81473185268, 17284.740728889075, 17346.219420126094, 17977.64044719105, 18063.4580962571, 18113.45659630213, 5060.569851562613, 5246.921296180561, 5253.0544501989625, 5264.657797243167, 5304.443033481468, 3671.4859919611276, 4128.0, 5150.974245128769, 6194.256689197303, 6352.301246862841, 6271.655058971754, 6272.749090036393, 6276.68616569172, 6288.30828608855, 6306.49548036156, 6100.328963813977, 6174.413430724074, 6218.595791273553, 6229.813105606839, 6238.4385405313515, 5183.948160518422, 5286.0, 5468.72656367184, 5470.234167216593, 5471.905618876201, 18781.24875004998, 20004.399868003984, 21613.567728645496, 21737.2391966282, 21892.343229702976, 1973.4079776067122, 1990.2735501541977, 1996.4509759816021, 2008.8694234874686, 2209.5470428562107, 9380.484073375961, 9480.668176613854, 9572.664956726481, 11271.0, 13565.59303220905, 1800.1359347513137, 1836.4215272189217, 1860.153630098302, 1872.4289091827125, 1898.364048043907, 70289.2971070293, 72658.0, 72968.27031729667, 73607.0, 73714.63142684252, 9955.402675839472, 10010.299279050541, 10451.0, 10475.738106547245, 10587.100096491731, 14012.299385030708, 14025.368858401396, 14057.929710351384, 14143.85856141446, 14151.43394264218, 7017.0, 7111.679974401164, 7117.572945623279, 7156.069710937649, 7171.175314838756, 6502.44729198014, 6524.771632992823, 6551.181102362205, 6713.462922966151, 6756.76351327711, 4234.174336004449, 4269.295566231599, 4438.489573699066, 4460.933086003713, 4517.080240897605, 1854.6290741851683, 1873.8313551780404, 1888.3768356442615, 1911.5603411215498, 1934.2456441987636, 796.38678217772, 867.4795122926193, 867.696306292805, 903.3089686389917, 919.8206349761866, 17061.0, 17101.572460688334, 17171.828281717273, 17519.91240043817, 17722.822771772375, 831.2186544648011, 869.9304055675531, 892.5626443042992, 946.9526523673788, 948.9430634161835, 9932.404055756677, 9975.0, 10060.597576097021, 10083.798324033478, 10083.848742268872, 411403.0, 411551.0, 415544.0, 438622.0, 440773.0, 46762.532374675815, 51956.74021629943, 79140.0, 84142.15857841466, 86650.30220920221, 853.7396094191207, 887.8002449448823, 904.2675432899373, 905.5472263868066, 905.5698543192062, 15978.946323055046, 15994.200289985221, 16269.59326016859, 16576.75134873002, 16924.984500929982, 36657.45013824848, 38067.0, 39359.60640393559, 39883.80058099691, 40182.39726404165, 54124.0, 54841.451585483635, 55358.72320638371, 55405.0, 55549.44450555443, 7373.668184931798, 7522.811929701582, 7528.962355188189, 7570.470067095251, 7627.275408836152, 8991.775205619912, 11304.660860174208, 11396.373199473777, 11400.0, 11448.828267575826, 9491.620335186515, 9495.762605934908, 9712.0, 9725.513724313614, 9739.610415583298, 10176.135028522658, 10242.56604075445, 10363.274570779973, 10364.0, 10567.418791966516, 8851.336149788664, 9369.390989585656, 9534.713958581253, 9691.321607487409, 9817.31278810505, 6740.056392105012, 6946.0, 7030.543014704028, 7246.5289756165685, 7381.557106573623, 9464.053594640482, 9541.809163816824, 9667.274954378308, 9686.370385924893, 9712.70861874145], "value": 8348.321416783967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.3393137362696, 1383.8131852199954, 1452.2303179314968, 1631.7492930914966, 1670.1231853277036, 6805.761798337059, 7372.078490188726, 7516.81207969801, 7955.124936257007, 7982.800429989253, 7561.319481246686, 7787.454878158531, 7815.218478152182, 7853.450258481908, 7856.489328193664, 2151.333086743111, 2210.3810932938804, 2211.1266049910278, 2213.3581261434165, 2218.279059305724, 2163.3077415227135, 2188.616992026397, 2213.6900833883187, 2217.523232505011, 2228.765979572146, 2175.695402643631, 2184.7050648162535, 2184.847060705751, 2193.7586865444787, 2213.18112298449, 2146.64580344243, 2149.1618268875072, 2166.5775173841107, 2169.425102347879, 2170.370592528165, 2098.2970704813906, 2142.528643698384, 2148.495103650641, 2156.8813715245656, 2158.330917415606, 7805.063392392949, 7810.531368117931, 7862.803429914241, 7866.763997080039, 7874.685012599489, 4402.691811573191, 4552.8861778455475, 4585.70192937458, 4592.035672508777, 4608.953910460886, 2855.4146399988163, 2861.957070643942, 2932.252275669691, 2945.6759756426777, 2994.401119776032, 920.9677661281889, 950.6530116507494, 965.0205041882494, 967.5404183013083, 984.0848011349442, 10546.683599492104, 10579.153667706565, 10586.576536938514, 10611.84082238767, 10632.787344253149, 3978.303796835542, 4053.2906741320153, 4186.769727665008, 4210.073783767566, 4215.0, 9002.0, 9023.368364214442, 9046.0, 9052.728418147335, 9056.592453339616, 4580.656450766206, 4595.931061034087, 4618.468876079227, 4621.214393553104, 4633.166030114612, 3733.0667333166707, 3994.900127496836, 4136.73111247768, 4222.071144348239, 4231.428757117811, 3598.5681718193982, 3622.4385220290897, 3691.7046636269033, 3706.388445906395, 3716.6655001050035, 1152.9365884876245, 1197.1859135787574, 1200.8438902942737, 1215.641385791176, 1215.7082300247878, 675.5170053411834, 799.6481548118809, 804.5092493578912, 819.5574389829426, 819.7868554175957, 4837.371141751621, 4964.503549645079, 5062.569681577033, 5066.442691303953, 5104.515071068243, 393.15079428434444, 393.2018003452995, 395.5194438756924, 402.2196937940386, 402.7120608764747, 3251.544783730232, 3329.450640644315, 3333.1333853197857, 3380.9012071077, 3428.708559772447, 9152.725418237464, 9621.326507144573, 9653.806923861483, 9660.37207581505, 9664.178544823628, 9374.343795934356, 9528.333016688764, 9547.188488978376, 9586.328956972944, 9590.472524011246, 7055.682494287769, 7099.964500177466, 7146.392556632641, 7154.928450715531, 7178.17450993132, 4786.6410019248, 4878.536439068194, 4919.139150648693, 4994.650374473752, 5000.824971125993, 8628.827423451621, 8816.074312197383, 8855.91144088551, 8911.55442227899, 8957.820843582962, 8974.0, 9038.819223615359, 9087.954885188023, 9102.226310763659, 9178.173964342974, 6072.1498990140535, 6393.520485963479, 6650.933490665031, 6795.456363491007, 6808.0, 7519.812004699927, 7524.623768811647, 7531.171571127281, 7594.6202689866395, 7609.353204977418, 6575.375339342755, 6750.0, 6799.796006119825, 6828.863422731617, 6857.794266172023, 6732.427743641845, 6754.5609535380045, 6825.488088393489, 6879.105716256855, 6890.621015844176, 5632.971835140962, 5902.793402230901, 5977.073553599199, 6004.159417681441, 6007.068904319837, 4369.344598310279, 4445.911081778411, 4522.683412161117, 4594.575681538734, 4599.2871104978785, 4418.160549495586, 4466.776661166994, 4489.19194544985, 4572.771361431848, 4599.954000459952], "value": 4008.568598340515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.4978612748498, 290.48149053938715, 295.13819646631833, 296.6469900818026, 298.82220079052956, 4944.664940466072, 5018.598512119031, 5144.279800827882, 5185.481451854813, 5217.713025783581, 4998.825041123561, 5025.170846810281, 5030.465707959071, 5049.0, 5051.040302342552, 3993.5423570396742, 3995.900102497439, 4050.898727531806, 4054.9594504054876, 4065.6137666921595, 3949.0, 4045.19096180765, 4051.210014047262, 4062.045419326456, 4072.328065869128, 3987.6211759882763, 3989.9800500997453, 3990.501187351581, 3994.1412596291793, 4002.6997975151835, 3992.8402863885553, 3996.760194388317, 4012.4583181270445, 4030.0, 4034.959650403517, 3420.4698271767916, 3525.823708814549, 3545.663161999606, 3546.184377593168, 3563.750537462379, 5031.949680503221, 5045.873853153664, 5049.495050494921, 5060.797568097271, 5067.417247016567, 4596.54034596541, 4657.138429390574, 4660.836870709542, 4684.1334353144775, 4686.882827929295, 5237.607179461517, 5319.696674314779, 5332.32031909951, 5351.6521426107565, 5410.48600382963, 3874.728768986172, 3880.631340022693, 3882.7282090253693, 3887.1059656279213, 3897.142628621699, 5641.12562552805, 5699.2306038684665, 5707.800226992077, 5720.2849643794525, 5725.284339457609, 3922.195949830278, 3971.146203566247, 3982.203559288154, 3993.381025940984, 4027.2146931348693, 4050.432939388488, 4053.1691003344245, 4056.0936359910793, 4057.9797101014306, 4069.409935559327, 4534.7052441591195, 4590.862274131781, 4612.3542704021465, 4616.95383046172, 4617.9307310389695, 5148.0, 5405.972970135203, 5409.0, 5422.213779002102, 5450.236966824647, 1324.198859689893, 1363.9454421823214, 1391.3947432866735, 1392.046448182998, 1405.8331584784605, 951.543259235557, 953.5470651440648, 961.0629636104882, 975.8731364922514, 977.9926675524222, 4620.792064357112, 4630.282306242538, 4645.0477652081245, 4653.488116307203, 4656.5110663379855, 5449.509544140967, 5504.862378440571, 5596.664200148004, 5609.382967873531, 5612.719364031782, 4524.502304746476, 4640.883977900579, 4652.371929789503, 4672.742999135012, 4728.503507131702, 2601.973980260211, 2607.8696065196664, 2610.5040042392266, 2626.500964816679, 2645.642838216816, 4594.264917613166, 4600.700954437951, 4604.309353596987, 4617.515160908057, 4624.861254162381, 4757.738324392122, 4913.631477639191, 4961.181405068123, 4970.8303364501235, 5006.723285562159, 4539.500654927955, 4586.835083792173, 4619.260918253063, 4640.118377508263, 4673.859784206344, 4939.777710003131, 4945.8021679132435, 4964.702117872939, 4964.751762411937, 4971.900561988812, 4430.737239886616, 4766.285057241442, 4768.737719425465, 4795.736234506996, 4803.255495398079, 4518.164139634178, 4603.700759450625, 4614.623468913579, 4635.397398338195, 4652.767361631973, 3633.836477358472, 3650.6349365064343, 3656.3601369759654, 3660.5607327120915, 3693.9076523087138, 4839.540243676845, 4861.854144375674, 4966.776495057803, 5255.78976840922, 5318.787248510016, 5378.650387724785, 5391.865203369947, 5393.7033463159905, 5399.865003374947, 5409.863928574886, 5305.204219367126, 5341.252224688625, 5343.278657381204, 5357.437469065848, 5368.0406651572675, 5098.490150985021, 5199.48005199477, 5274.604404669742, 5279.604029697711, 5312.309399778004, 5415.918761218506, 5434.402215756343, 5471.644343117685, 5479.917801233064, 5479.945200547943, 5292.708901010481, 5302.469753024667, 5303.496167864047, 5315.521603055744, 5363.0882749931825], "value": 3946.0216914206694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.8208214412459, 619.9597026193294, 671.3722669304201, 705.6295444891431, 708.3483195460176, 11514.942425287873, 11807.645770626874, 11947.880521194786, 12024.579139730122, 12028.0, 11497.942510287457, 11601.245919015279, 11601.361925094116, 11622.535098596067, 11729.120315976294, 766.9731559395423, 795.4670370851543, 797.1191833024511, 797.972070977516, 798.9360851131895, 780.6292011294618, 780.9258120478573, 782.0, 787.5943888897223, 788.2629741191976, 837.6105111123327, 838.7483754873545, 839.7900524868783, 840.1346612988632, 842.0821304777791, 826.6817275349003, 831.8003679116998, 832.009908209229, 834.3533761334953, 835.4068611285934, 612.6324205476723, 615.756776073453, 617.1206031405275, 618.9226346706662, 619.9101130336076, 11938.522459101625, 12010.939945300217, 12034.81947770784, 12048.337341446217, 12085.758284834343, 12060.638180854588, 12324.630261092181, 12641.431135598828, 12756.61730148097, 13019.0, 9567.282453815991, 9572.760680982961, 9611.663591774324, 9706.077922597342, 9772.071653192936, 3052.084374687585, 3077.569140320357, 3087.9691203087905, 3096.5355196720448, 3122.3911337289237, 61684.0, 62768.0, 63579.36420635781, 64043.67978160126, 64087.0, 9691.224702023963, 9764.365316254421, 9789.0, 9840.015998400102, 10043.899561004297, 16094.19529023544, 16633.417830376122, 16701.832981670028, 17472.65054698899, 17533.0, 6682.866342673119, 6813.829654258584, 6828.897566536407, 6833.180018397824, 7013.403860671798, 3541.220931395089, 3574.98212508941, 3577.159367548624, 3619.6561326673923, 3769.98210483168, 2789.3723912120017, 2879.827210367385, 2883.538633818579, 2883.596296518489, 2888.6100376448912, 507.5229284472584, 512.4670342843475, 517.981870634526, 518.1502336168686, 522.7673685210121, 476.36881132499576, 538.9434109418534, 550.4193076304457, 551.503646717957, 563.8477611044995, 7416.555006699616, 7496.925030749622, 7578.280063393969, 7686.654100565488, 7868.921310786819, 546.7621584610707, 550.5017958747341, 551.0824477245421, 553.8037838269319, 566.6684989281316, 3619.5656521217625, 3631.673149416565, 3673.0, 3705.8517659293325, 3710.5547334320054, 51528.74235628798, 51735.48264517307, 51764.48235517672, 84934.72597911036, 92370.53814731017, 48904.7554762231, 80912.19087809046, 82048.0, 83154.58422707969, 84379.57810211032, 43733.56266437359, 45892.77053614777, 73964.63017684985, 74207.62896185592, 74430.0, 6744.763933262312, 6945.583265003914, 6971.442284617117, 7041.119860017498, 7113.644317784194, 44554.0, 44666.10667786561, 44835.0, 45126.54873451355, 46165.53834461747, 50129.74935125301, 60800.69599651973, 60909.0, 61025.0, 61534.69232653808, 9397.906020939703, 9703.369280996994, 9740.366876153028, 9789.412635241908, 10058.748531286776, 10917.945410273216, 10958.890411096107, 10981.121510279, 11002.614908478165, 11014.339139651647, 9228.769280768034, 9287.907120928705, 9330.626774928927, 9504.667336643184, 9510.429374237568, 10071.597136114766, 10230.28388012832, 10278.229132814919, 10446.05985461312, 10863.511141998471, 9807.362521436084, 9895.0, 10068.69793906184, 10078.899211007796, 10146.898531014891, 8490.448120872123, 8527.888594295762, 8573.142685731627, 8627.6980305689, 8718.215360617574, 8473.322134229371, 8676.305895528216, 8873.778155546162, 8925.866112008454, 9078.09219078087], "value": 6072.865625673178, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 108.0, 116.0, 114.0, 116.0, 117.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 124.0, 152.0, 181.0, 125.0, 158.0, 158.0, 127.0, 200.0, 125.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 172.0, 168.0, 163.0, 162.0, 169.0, 163.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 156.0, 76.0, 76.0, 76.0, 75.0, 156.0, 77.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 145.0, 86.0, 87.0, 87.0, 142.0, 86.0, 87.0, 135.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 149.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 64.0, 65.0, 71.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 86.0, 78.0, 78.0, 79.0, 77.0, 79.0, 82.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 130.0, 145.0, 131.0, 131.0, 130.0, 142.0, 171.0, 135.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 170.0, 164.0, 173.0, 169.0, 166.0, 162.0, 167.0, 163.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 69.0, 68.0, 67.0, 68.0, 67.0, 71.0, 66.0], "value": 68.6, "unit": "score"}]}]} 15:53:02 INFO - Return code: 0 15:53:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:53:02 ERROR - # TBPL SUCCESS # 15:53:02 INFO - Running post-action listener: _resource_record_post_action 15:53:02 INFO - ##### 15:53:02 INFO - ##### Finished run-tests step (success) 15:53:02 INFO - ##### 15:53:02 INFO - Running post-run listener: _resource_record_post_run 15:53:02 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301588480; Read time: 16; Write time: 312776 15:53:02 INFO - TinderboxPrint: CPU usage
13.4% 15:53:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:53:02 INFO - TinderboxPrint: I/O write bytes / time
301,588,480 / 312,776 15:53:02 INFO - TinderboxPrint: CPU idle
8,274.2 (86.6%) 15:53:02 INFO - TinderboxPrint: CPU user
1,223.8 (12.8%) 15:53:02 INFO - TinderboxPrint: Swap in / out
0 / 0 15:53:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 17440768; Read time: 0; Write time: 2388 15:53:02 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 284147712; Read time: 0; Write time: 310388 15:53:02 INFO - Running post-run listener: _upload_blobber_files 15:53:02 INFO - Blob upload gear active. 15:53:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:53:02 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 15:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:53:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:03 INFO - (blobuploader) - INFO - Done attempting. 15:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:04 INFO - (blobuploader) - INFO - Done attempting. 15:53:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:53:08 INFO - (blobuploader) - INFO - Done attempting. 15:53:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:53:08 INFO - Return code: 0 15:53:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:53:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:53:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78a046b81c5ef71b03f1996d2ff416072114cfcf625772bf2586b42a877fcd8cf4655c23fe2a0aa74536dff9cf9dceeddfc62e45c35a2d072a12db9b051f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c696bed9b0c3a7346f47fd3bfa17ecbca7e6f3701a72ec025b2e24480443e10ccf9c7870267c929fcdcdb2855b860a8b3fb159a349a37f5ce4cccf8c173080c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0404cf2eff4ef462d05e9d1f80dd391e149224e52e5584f15f68b3a3f82ec332a2ef3a3d77e05bdb96b30f53f808da1334d0bf3d741036a00f0882ebe9383c4"} 15:53:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:53:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:53:08 INFO - Contents: 15:53:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78a046b81c5ef71b03f1996d2ff416072114cfcf625772bf2586b42a877fcd8cf4655c23fe2a0aa74536dff9cf9dceeddfc62e45c35a2d072a12db9b051f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c696bed9b0c3a7346f47fd3bfa17ecbca7e6f3701a72ec025b2e24480443e10ccf9c7870267c929fcdcdb2855b860a8b3fb159a349a37f5ce4cccf8c173080c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0404cf2eff4ef462d05e9d1f80dd391e149224e52e5584f15f68b3a3f82ec332a2ef3a3d77e05bdb96b30f53f808da1334d0bf3d741036a00f0882ebe9383c4"} 15:53:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:53:08 INFO - Copying logs to upload dir... 15:53:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:53:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1357.556677 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2016-06-29 15:53:08.213740) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 15:53:08.217223) ========= 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=fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78a046b81c5ef71b03f1996d2ff416072114cfcf625772bf2586b42a877fcd8cf4655c23fe2a0aa74536dff9cf9dceeddfc62e45c35a2d072a12db9b051f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c696bed9b0c3a7346f47fd3bfa17ecbca7e6f3701a72ec025b2e24480443e10ccf9c7870267c929fcdcdb2855b860a8b3fb159a349a37f5ce4cccf8c173080c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0404cf2eff4ef462d05e9d1f80dd391e149224e52e5584f15f68b3a3f82ec332a2ef3a3d77e05bdb96b30f53f808da1334d0bf3d741036a00f0882ebe9383c4"} build_url:https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/Ghc-RCOVT6e8hMl5LE_7Ig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d78a046b81c5ef71b03f1996d2ff416072114cfcf625772bf2586b42a877fcd8cf4655c23fe2a0aa74536dff9cf9dceeddfc62e45c35a2d072a12db9b051f7ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c696bed9b0c3a7346f47fd3bfa17ecbca7e6f3701a72ec025b2e24480443e10ccf9c7870267c929fcdcdb2855b860a8b3fb159a349a37f5ce4cccf8c173080c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a0404cf2eff4ef462d05e9d1f80dd391e149224e52e5584f15f68b3a3f82ec332a2ef3a3d77e05bdb96b30f53f808da1334d0bf3d741036a00f0882ebe9383c4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 15:53:08.243673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:53:08.244035) ========= 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=fa44defc139c4ba8574fe040000001db-1467239428.65399-955040808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:53:08.329555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 15:53:08.329901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 15:53:08.330254) ========= ========= Total master_lag: 0.16 =========