builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1467244559.6 results: success (0) buildid: 20160629143024 builduid: 64831469a0cd4a869f5c0d9234a5f599 revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.598933) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.599397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.599696) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.630158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.630610) ========= 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=df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 16:55:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-29 16:55:59 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.749207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.752608) ========= 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=df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017956 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:55:59.808552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 16:55:59.808925) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ecfdfb4a997766e51465fadc7453097a830b372 --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 5ecfdfb4a997766e51465fadc7453097a830b372 --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=df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 16:55:59,994 truncating revision to first 12 chars 2016-06-29 16:55:59,994 Setting DEBUG logging. 2016-06-29 16:55:59,994 attempt 1/10 2016-06-29 16:55:59,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ecfdfb4a997?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 16:56:01,268 unpacking tar archive at: fx-team-5ecfdfb4a997/testing/mozharness/ program finished with exit code 0 elapsedTime=1.616590 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 16:56:01.451067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 16:56:01.451381) ========= script_repo_revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 16:56:01.451806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 16:56:01.452080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 16:56:01.462697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-29 16:56:01.463065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:01 INFO - MultiFileLogger online at 20160629 16:56:01 in /builds/slave/test 16:56:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:56:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:01 INFO - {'append_to_log': False, 16:56:01 INFO - 'base_work_dir': '/builds/slave/test', 16:56:01 INFO - 'blob_upload_branch': 'Fx-Team', 16:56:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:01 INFO - 'branch': 'Fx-Team', 16:56:01 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:01 INFO - 'config_files': ('talos/linux_config.py',), 16:56:01 INFO - 'default_actions': ('clobber', 16:56:01 INFO - 'read-buildbot-config', 16:56:01 INFO - 'download-and-extract', 16:56:01 INFO - 'populate-webroot', 16:56:01 INFO - 'create-virtualenv', 16:56:01 INFO - 'install', 16:56:01 INFO - 'run-tests'), 16:56:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:01 INFO - 'download_minidump_stackwalk': True, 16:56:01 INFO - 'download_symbols': 'ondemand', 16:56:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:01 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:01 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:01 INFO - 'installer_path': 'installer.exe', 16:56:01 INFO - 'log_level': 'info', 16:56:01 INFO - 'log_name': 'talos', 16:56:01 INFO - 'log_to_console': True, 16:56:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:01 INFO - 'opt_config_files': (), 16:56:01 INFO - 'pip_index': False, 16:56:01 INFO - 'sps_profile': False, 16:56:01 INFO - 'sps_profile_interval': 0, 16:56:01 INFO - 'suite': 'dromaeojs-e10s', 16:56:01 INFO - 'system_bits': '32', 16:56:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:01 INFO - 'title': 'talos-linux64-ix-021', 16:56:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:01 INFO - 'use_talos_json': True, 16:56:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:01 INFO - 'work_dir': 'build'} 16:56:01 INFO - ##### 16:56:01 INFO - ##### Running clobber step. 16:56:01 INFO - ##### 16:56:01 INFO - Running pre-action listener: _resource_record_pre_action 16:56:01 INFO - Running main action method: clobber 16:56:01 INFO - rmtree: /builds/slave/test/build 16:56:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:02 INFO - Running post-action listener: _resource_record_post_action 16:56:02 INFO - ##### 16:56:02 INFO - ##### Finished clobber step (success) 16:56:02 INFO - ##### 16:56:02 INFO - ##### 16:56:02 INFO - ##### Running read-buildbot-config step. 16:56:02 INFO - ##### 16:56:02 INFO - Running pre-action listener: _resource_record_pre_action 16:56:02 INFO - Running main action method: read_buildbot_config 16:56:02 INFO - Using buildbot properties: 16:56:02 INFO - { 16:56:02 INFO - "project": "", 16:56:02 INFO - "product": "firefox", 16:56:02 INFO - "script_repo_revision": "production", 16:56:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:56:02 INFO - "repository": "", 16:56:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:56:02 INFO - "buildid": "20160629143024", 16:56:02 INFO - "pgo_build": "True", 16:56:02 INFO - "basedir": "/builds/slave/test", 16:56:02 INFO - "buildnumber": 519, 16:56:02 INFO - "slavename": "talos-linux64-ix-021", 16:56:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:56:02 INFO - "platform": "ubuntu64_hw", 16:56:02 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:56:02 INFO - "branch": "fx-team", 16:56:02 INFO - "repo_path": "integration/fx-team", 16:56:02 INFO - "revision": "5ecfdfb4a997766e51465fadc7453097a830b372", 16:56:02 INFO - "stage_platform": "linux64-pgo", 16:56:02 INFO - "builduid": "64831469a0cd4a869f5c0d9234a5f599", 16:56:02 INFO - "slavebuilddir": "test" 16:56:02 INFO - } 16:56:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:56:02 INFO - Running post-action listener: _resource_record_post_action 16:56:02 INFO - ##### 16:56:02 INFO - ##### Finished read-buildbot-config step (success) 16:56:02 INFO - ##### 16:56:02 INFO - ##### 16:56:02 INFO - ##### Running download-and-extract step. 16:56:02 INFO - ##### 16:56:02 INFO - Running pre-action listener: _resource_record_pre_action 16:56:02 INFO - Running main action method: download_and_extract 16:56:02 INFO - mkdir: /builds/slave/test/build/tests 16:56:02 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')]} 16:56:02 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:56:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:56:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:56:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:03 INFO - Downloaded 1361 bytes. 16:56:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:56:03 INFO - Using the following test package requirements: 16:56:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:56:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:56:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'jsshell-linux-x86_64.zip'], 16:56:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:56:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:56:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:56:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:56:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:56:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:03 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:56:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:56:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:05 INFO - Downloaded 24268174 bytes. 16:56:05 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'] 16:56:05 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 16:56:06 INFO - Return code: 0 16:56:06 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 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:06 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:56:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:56:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:08 INFO - Downloaded 24268174 bytes. 16:56:08 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'] 16:56:08 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 16:56:09 INFO - Return code: 0 16:56:09 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')]} 16:56:09 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:13 INFO - Downloaded 14405245 bytes. 16:56:13 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'] 16:56:13 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 16:56:14 INFO - Return code: 0 16:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:14 INFO - https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANzTA9o0QRetYPwyLL_ukg/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 16:56:17 INFO - Downloaded 60337418 bytes. 16:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:56:17 INFO - mkdir: /builds/slave/test/properties 16:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:56:17 INFO - Writing to file /builds/slave/test/properties/build_url 16:56:17 INFO - Contents: 16:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:56:18 INFO - Running post-action listener: _resource_record_post_action 16:56:18 INFO - Running post-action listener: set_extra_try_arguments 16:56:18 INFO - ##### 16:56:18 INFO - ##### Finished download-and-extract step (success) 16:56:18 INFO - ##### 16:56:18 INFO - ##### 16:56:18 INFO - ##### Running populate-webroot step. 16:56:18 INFO - ##### 16:56:18 INFO - Running pre-action listener: _resource_record_pre_action 16:56:18 INFO - Running main action method: populate_webroot 16:56:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:56:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:56:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:56:18 INFO - '--tppagecycles', 16:56:18 INFO - '7'], 16:56:18 INFO - 'tests': ['tsvgm']}}, 16:56:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:56:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:56:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:56:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:56:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['damp', 'tps']}, 16:56:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'tests': ['damp', 'tps']}, 16:56:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['dromaeo_dom']}, 16:56:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:56:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['basic_compositor_video']}, 16:56:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:56:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other-e10s': {'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['tsvgx', 16:56:18 INFO - 'tsvgr_opacity', 16:56:18 INFO - 'tart', 16:56:18 INFO - 'tscrollx', 16:56:18 INFO - 'cart']}, 16:56:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:56:18 INFO - 'tsvgr_opacity', 16:56:18 INFO - 'tart', 16:56:18 INFO - 'tscrollx', 16:56:18 INFO - 'cart']}, 16:56:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--disable-e10s'], 16:56:18 INFO - 'tests': ['tp5o']}, 16:56:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'tests': ['tp5o']}, 16:56:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--disable-e10s', 16:56:18 INFO - '--xperf_path', 16:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:18 INFO - 'tests': ['tp5n']}, 16:56:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--xperf_path', 16:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:18 INFO - 'tests': ['tp5n']}}, 16:56:18 INFO - 'talos.zip': {'path': '', 16:56:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:56:18 INFO - Running post-action listener: _resource_record_post_action 16:56:18 INFO - ##### 16:56:18 INFO - ##### Finished populate-webroot step (success) 16:56:18 INFO - ##### 16:56:18 INFO - ##### 16:56:18 INFO - ##### Running create-virtualenv step. 16:56:18 INFO - ##### 16:56:18 INFO - Running pre-action listener: _resource_record_pre_action 16:56:18 INFO - Running main action method: create_virtualenv 16:56:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:56:18 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 16:56:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:56:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:56:18 INFO - Using real prefix '/usr' 16:56:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:56:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:56:21 INFO - Installing pip.................done. 16:56:21 INFO - Return code: 0 16:56:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:21 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:21 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 16:56:21 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 16:56:21 INFO - Using env: {'DISPLAY': ':0', 16:56:21 INFO - 'HOME': '/home/cltbld', 16:56:21 INFO - 'LANG': 'en_US.UTF-8', 16:56:21 INFO - 'LANGUAGE': 'en_US:en', 16:56:21 INFO - 'LOGNAME': 'cltbld', 16:56:21 INFO - 'MAIL': '/var/mail/cltbld', 16:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:21 INFO - 'MOZ_NO_REMOTE': '1', 16:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:21 INFO - 'NO_EM_RESTART': '1', 16:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:21 INFO - 'PWD': '/builds/slave/test', 16:56:21 INFO - 'SHELL': '/bin/bash', 16:56:21 INFO - 'SHLVL': '1', 16:56:21 INFO - 'TERM': 'linux', 16:56:21 INFO - 'TMOUT': '86400', 16:56:21 INFO - 'USER': 'cltbld', 16:56:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:21 INFO - '_': '/tools/buildbot/bin/python'} 16:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:21 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 16:56:21 INFO - Cleaning up... 16:56:21 INFO - Return code: 0 16:56:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:21 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:21 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 16:56:21 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 16:56:21 INFO - Using env: {'DISPLAY': ':0', 16:56:21 INFO - 'HOME': '/home/cltbld', 16:56:21 INFO - 'LANG': 'en_US.UTF-8', 16:56:21 INFO - 'LANGUAGE': 'en_US:en', 16:56:21 INFO - 'LOGNAME': 'cltbld', 16:56:21 INFO - 'MAIL': '/var/mail/cltbld', 16:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:21 INFO - 'MOZ_NO_REMOTE': '1', 16:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:21 INFO - 'NO_EM_RESTART': '1', 16:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:21 INFO - 'PWD': '/builds/slave/test', 16:56:21 INFO - 'SHELL': '/bin/bash', 16:56:21 INFO - 'SHLVL': '1', 16:56:21 INFO - 'TERM': 'linux', 16:56:21 INFO - 'TMOUT': '86400', 16:56:21 INFO - 'USER': 'cltbld', 16:56:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:21 INFO - '_': '/tools/buildbot/bin/python'} 16:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:21 INFO - Downloading/unpacking psutil>=3.1.1 16:56:21 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 16:56:21 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 16:56:21 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 16:56:21 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 16:56:21 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 16:56:21 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 16:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:56:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:23 INFO - Installing collected packages: psutil 16:56:23 INFO - Running setup.py install for psutil 16:56:23 INFO - building 'psutil._psutil_linux' extension 16:56:23 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 16:56:23 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 16:56:23 INFO - building 'psutil._psutil_posix' extension 16:56:23 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 16:56:24 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 16:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:24 INFO - Successfully installed psutil 16:56:24 INFO - Cleaning up... 16:56:24 INFO - Return code: 0 16:56:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:56:24 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')]} 16:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:24 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')]} 16:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:24 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:24 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 16:56:24 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 16:56:24 INFO - Using env: {'DISPLAY': ':0', 16:56:24 INFO - 'HOME': '/home/cltbld', 16:56:24 INFO - 'LANG': 'en_US.UTF-8', 16:56:24 INFO - 'LANGUAGE': 'en_US:en', 16:56:24 INFO - 'LOGNAME': 'cltbld', 16:56:24 INFO - 'MAIL': '/var/mail/cltbld', 16:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:24 INFO - 'MOZ_NO_REMOTE': '1', 16:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:24 INFO - 'NO_EM_RESTART': '1', 16:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:24 INFO - 'PWD': '/builds/slave/test', 16:56:24 INFO - 'SHELL': '/bin/bash', 16:56:24 INFO - 'SHLVL': '1', 16:56:24 INFO - 'TERM': 'linux', 16:56:24 INFO - 'TMOUT': '86400', 16:56:24 INFO - 'USER': 'cltbld', 16:56:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:24 INFO - '_': '/tools/buildbot/bin/python'} 16:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:56:24 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 16:56:24 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 16:56:24 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 16:56:24 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 16:56:24 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 16:56:24 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 16:56:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:56:26 INFO - Installing collected packages: mozsystemmonitor 16:56:26 INFO - Running setup.py install for mozsystemmonitor 16:56:26 INFO - Successfully installed mozsystemmonitor 16:56:26 INFO - Cleaning up... 16:56:26 INFO - Return code: 0 16:56:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:26 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:26 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 16:56:26 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 16:56:26 INFO - Using env: {'DISPLAY': ':0', 16:56:26 INFO - 'HOME': '/home/cltbld', 16:56:26 INFO - 'LANG': 'en_US.UTF-8', 16:56:26 INFO - 'LANGUAGE': 'en_US:en', 16:56:26 INFO - 'LOGNAME': 'cltbld', 16:56:26 INFO - 'MAIL': '/var/mail/cltbld', 16:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:26 INFO - 'MOZ_NO_REMOTE': '1', 16:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:26 INFO - 'NO_EM_RESTART': '1', 16:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:26 INFO - 'PWD': '/builds/slave/test', 16:56:26 INFO - 'SHELL': '/bin/bash', 16:56:26 INFO - 'SHLVL': '1', 16:56:26 INFO - 'TERM': 'linux', 16:56:26 INFO - 'TMOUT': '86400', 16:56:26 INFO - 'USER': 'cltbld', 16:56:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:26 INFO - '_': '/tools/buildbot/bin/python'} 16:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:26 INFO - Downloading/unpacking jsonschema==2.5.1 16:56:26 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 16:56:26 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 16:56:26 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 16:56:26 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 16:56:26 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 16:56:26 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 16:56:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:56:28 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 16:56:28 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 16:56:28 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 16:56:28 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 16:56:28 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 16:56:28 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 16:56:28 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:28 INFO - warning: no files found matching '*.txt' 16:56:28 INFO - no previously-included directories found matching 'build' 16:56:28 INFO - no previously-included directories found matching 'dist' 16:56:28 INFO - no previously-included directories found matching '.git*' 16:56:28 INFO - Installing collected packages: jsonschema, functools32 16:56:28 INFO - Running setup.py install for functools32 16:56:29 INFO - warning: no files found matching '*.txt' 16:56:29 INFO - no previously-included directories found matching 'build' 16:56:29 INFO - no previously-included directories found matching 'dist' 16:56:29 INFO - no previously-included directories found matching '.git*' 16:56:29 INFO - Successfully installed jsonschema functools32 16:56:29 INFO - Cleaning up... 16:56:29 INFO - Return code: 0 16:56:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:56:29 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')]} 16:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:29 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')]} 16:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:29 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:29 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 16:56:29 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 16:56:29 INFO - Using env: {'DISPLAY': ':0', 16:56:29 INFO - 'HOME': '/home/cltbld', 16:56:29 INFO - 'LANG': 'en_US.UTF-8', 16:56:29 INFO - 'LANGUAGE': 'en_US:en', 16:56:29 INFO - 'LOGNAME': 'cltbld', 16:56:29 INFO - 'MAIL': '/var/mail/cltbld', 16:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:29 INFO - 'MOZ_NO_REMOTE': '1', 16:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:29 INFO - 'NO_EM_RESTART': '1', 16:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:29 INFO - 'PWD': '/builds/slave/test', 16:56:29 INFO - 'SHELL': '/bin/bash', 16:56:29 INFO - 'SHLVL': '1', 16:56:29 INFO - 'TERM': 'linux', 16:56:29 INFO - 'TMOUT': '86400', 16:56:29 INFO - 'USER': 'cltbld', 16:56:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:29 INFO - '_': '/tools/buildbot/bin/python'} 16:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:29 INFO - Downloading/unpacking blobuploader==1.2.4 16:56:29 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 16:56:29 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 16:56:29 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 16:56:29 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 16:56:29 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 16:56:29 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 16:56:31 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:56:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:31 INFO - Downloading docopt-0.6.1.tar.gz 16:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:32 INFO - Running setup.py install for blobuploader 16:56:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:56:32 INFO - Running setup.py install for requests 16:56:32 INFO - Running setup.py install for docopt 16:56:32 INFO - Successfully installed blobuploader requests docopt 16:56:32 INFO - Cleaning up... 16:56:32 INFO - Return code: 0 16:56:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56: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')]} 16:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56: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')]} 16:56:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:32 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:32 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 16:56:32 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 16:56:32 INFO - Using env: {'DISPLAY': ':0', 16:56:32 INFO - 'HOME': '/home/cltbld', 16:56:32 INFO - 'LANG': 'en_US.UTF-8', 16:56:32 INFO - 'LANGUAGE': 'en_US:en', 16:56:32 INFO - 'LOGNAME': 'cltbld', 16:56:32 INFO - 'MAIL': '/var/mail/cltbld', 16:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:32 INFO - 'MOZ_NO_REMOTE': '1', 16:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:32 INFO - 'NO_EM_RESTART': '1', 16:56:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:32 INFO - 'PWD': '/builds/slave/test', 16:56:32 INFO - 'SHELL': '/bin/bash', 16:56:32 INFO - 'SHLVL': '1', 16:56:32 INFO - 'TERM': 'linux', 16:56:32 INFO - 'TMOUT': '86400', 16:56:32 INFO - 'USER': 'cltbld', 16:56:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:32 INFO - '_': '/tools/buildbot/bin/python'} 16:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:33 INFO - Running setup.py (path:/tmp/pip-hDB7Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:33 INFO - Running setup.py (path:/tmp/pip-UZNmCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:33 INFO - Running setup.py (path:/tmp/pip-cAvvOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:33 INFO - Running setup.py (path:/tmp/pip-CJNe8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:33 INFO - Running setup.py (path:/tmp/pip-_rdx1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:33 INFO - Running setup.py (path:/tmp/pip-13DRAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:33 INFO - Running setup.py (path:/tmp/pip-R14FlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:33 INFO - Running setup.py (path:/tmp/pip-zfq888-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:33 INFO - Running setup.py (path:/tmp/pip-4PqNfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:33 INFO - Running setup.py (path:/tmp/pip-pQXnJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:33 INFO - Running setup.py (path:/tmp/pip-It3Th0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:33 INFO - Running setup.py (path:/tmp/pip-I9gw8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:33 INFO - Running setup.py (path:/tmp/pip-0i6mBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:33 INFO - Running setup.py (path:/tmp/pip-U7Kube-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:34 INFO - Running setup.py (path:/tmp/pip-HHR3mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:34 INFO - Running setup.py (path:/tmp/pip-zfHLSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:34 INFO - Running setup.py (path:/tmp/pip-JZs5IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:34 INFO - Running setup.py install for manifestparser 16:56:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:34 INFO - Running setup.py install for mozcrash 16:56:34 INFO - Running setup.py install for mozdebug 16:56:34 INFO - Running setup.py install for mozdevice 16:56:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:56:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:34 INFO - Running setup.py install for mozfile 16:56:34 INFO - Running setup.py install for mozhttpd 16:56:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:34 INFO - Running setup.py install for mozinfo 16:56:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:34 INFO - Running setup.py install for mozInstall 16:56:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Running setup.py install for mozleak 16:56:35 INFO - Running setup.py install for mozlog 16:56:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Running setup.py install for moznetwork 16:56:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Running setup.py install for mozprocess 16:56:35 INFO - Running setup.py install for mozprofile 16:56:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Running setup.py install for mozrunner 16:56:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Running setup.py install for mozscreenshot 16:56:35 INFO - Running setup.py install for moztest 16:56:35 INFO - Running setup.py install for mozversion 16:56:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:35 INFO - Cleaning up... 16:56:36 INFO - Return code: 0 16:56:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:36 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:36 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 16:56:36 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 16:56:36 INFO - Using env: {'DISPLAY': ':0', 16:56:36 INFO - 'HOME': '/home/cltbld', 16:56:36 INFO - 'LANG': 'en_US.UTF-8', 16:56:36 INFO - 'LANGUAGE': 'en_US:en', 16:56:36 INFO - 'LOGNAME': 'cltbld', 16:56:36 INFO - 'MAIL': '/var/mail/cltbld', 16:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:36 INFO - 'MOZ_NO_REMOTE': '1', 16:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:36 INFO - 'NO_EM_RESTART': '1', 16:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:36 INFO - 'PWD': '/builds/slave/test', 16:56:36 INFO - 'SHELL': '/bin/bash', 16:56:36 INFO - 'SHLVL': '1', 16:56:36 INFO - 'TERM': 'linux', 16:56:36 INFO - 'TMOUT': '86400', 16:56:36 INFO - 'USER': 'cltbld', 16:56:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:36 INFO - '_': '/tools/buildbot/bin/python'} 16:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:36 INFO - Running setup.py (path:/tmp/pip-32POg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:36 INFO - Running setup.py (path:/tmp/pip-qoZTqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:36 INFO - Running setup.py (path:/tmp/pip-WvDf1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:36 INFO - Running setup.py (path:/tmp/pip-sBfP8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:36 INFO - Running setup.py (path:/tmp/pip-JyUvTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:36 INFO - Running setup.py (path:/tmp/pip-1SXXjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:36 INFO - Running setup.py (path:/tmp/pip-Tmx_Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:36 INFO - Running setup.py (path:/tmp/pip-9QSLiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:36 INFO - Running setup.py (path:/tmp/pip-Svjdqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:36 INFO - Running setup.py (path:/tmp/pip-bmMnYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:36 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)) 16:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:36 INFO - Running setup.py (path:/tmp/pip-m4HnlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:37 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)) 16:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:37 INFO - Running setup.py (path:/tmp/pip-uPjjFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:37 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)) 16:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:37 INFO - Running setup.py (path:/tmp/pip-1F0Bun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:37 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)) 16:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:37 INFO - Running setup.py (path:/tmp/pip-cixJGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:37 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)) 16:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:37 INFO - Running setup.py (path:/tmp/pip-cixSvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:37 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)) 16:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:37 INFO - Running setup.py (path:/tmp/pip-BTYcRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:37 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)) 16:56:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:37 INFO - Running setup.py (path:/tmp/pip-DGz9ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:37 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)) 16:56:37 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)) 16:56:37 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)) 16:56:37 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)) 16:56:37 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)) 16:56:37 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)) 16:56:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:37 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 16:56:37 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 16:56:37 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 16:56:37 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 16:56:37 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 16:56:37 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 16:56:39 INFO - Downloading blessings-1.6.tar.gz 16:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:39 INFO - Installing collected packages: blessings 16:56:39 INFO - Running setup.py install for blessings 16:56:39 INFO - Successfully installed blessings 16:56:39 INFO - Cleaning up... 16:56:39 INFO - Return code: 0 16:56:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:39 INFO - Reading from file tmpfile_stdout 16:56:39 INFO - Current package versions: 16:56:39 INFO - argparse == 1.2.1 16:56:39 INFO - blessings == 1.6 16:56:39 INFO - blobuploader == 1.2.4 16:56:39 INFO - docopt == 0.6.1 16:56:39 INFO - functools32 == 3.2.3-2 16:56:39 INFO - jsonschema == 2.5.1 16:56:39 INFO - manifestparser == 1.1 16:56:39 INFO - mozInstall == 1.12 16:56:39 INFO - mozcrash == 0.17 16:56:39 INFO - mozdebug == 0.1 16:56:39 INFO - mozdevice == 0.48 16:56:39 INFO - mozfile == 1.2 16:56:39 INFO - mozhttpd == 0.7 16:56:39 INFO - mozinfo == 0.9 16:56:39 INFO - mozleak == 0.1 16:56:39 INFO - mozlog == 3.2 16:56:39 INFO - moznetwork == 0.27 16:56:39 INFO - mozprocess == 0.22 16:56:39 INFO - mozprofile == 0.28 16:56:39 INFO - mozrunner == 6.11 16:56:39 INFO - mozscreenshot == 0.1 16:56:39 INFO - mozsystemmonitor == 0.3 16:56:39 INFO - moztest == 0.7 16:56:39 INFO - mozversion == 1.4 16:56:39 INFO - psutil == 3.1.1 16:56:39 INFO - requests == 1.2.3 16:56:39 INFO - wsgiref == 0.1.2 16:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:39 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:39 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 16:56:39 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 16:56:39 INFO - Using env: {'DISPLAY': ':0', 16:56:39 INFO - 'HOME': '/home/cltbld', 16:56:39 INFO - 'LANG': 'en_US.UTF-8', 16:56:39 INFO - 'LANGUAGE': 'en_US:en', 16:56:39 INFO - 'LOGNAME': 'cltbld', 16:56:39 INFO - 'MAIL': '/var/mail/cltbld', 16:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:39 INFO - 'MOZ_NO_REMOTE': '1', 16:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:39 INFO - 'NO_EM_RESTART': '1', 16:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:39 INFO - 'PWD': '/builds/slave/test', 16:56:39 INFO - 'SHELL': '/bin/bash', 16:56:39 INFO - 'SHLVL': '1', 16:56:39 INFO - 'TERM': 'linux', 16:56:39 INFO - 'TMOUT': '86400', 16:56:39 INFO - 'USER': 'cltbld', 16:56:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:39 INFO - '_': '/tools/buildbot/bin/python'} 16:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 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)) 16:56:40 INFO - Cleaning up... 16:56:40 INFO - Return code: 0 16:56:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:40 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 0x1b7f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e40180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, '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': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', '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 16:56:40 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 16:56:40 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 16:56:40 INFO - Using env: {'DISPLAY': ':0', 16:56:40 INFO - 'HOME': '/home/cltbld', 16:56:40 INFO - 'LANG': 'en_US.UTF-8', 16:56:40 INFO - 'LANGUAGE': 'en_US:en', 16:56:40 INFO - 'LOGNAME': 'cltbld', 16:56:40 INFO - 'MAIL': '/var/mail/cltbld', 16:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:40 INFO - 'MOZ_NO_REMOTE': '1', 16:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:40 INFO - 'NO_EM_RESTART': '1', 16:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:40 INFO - 'PWD': '/builds/slave/test', 16:56:40 INFO - 'SHELL': '/bin/bash', 16:56:40 INFO - 'SHLVL': '1', 16:56:40 INFO - 'TERM': 'linux', 16:56:40 INFO - 'TMOUT': '86400', 16:56:40 INFO - 'USER': 'cltbld', 16:56:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:40 INFO - '_': '/tools/buildbot/bin/python'} 16:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:56:40 INFO - Cleaning up... 16:56:40 INFO - Return code: 0 16:56:40 INFO - Running post-action listener: _resource_record_post_action 16:56:40 INFO - Running post-action listener: _start_resource_monitoring 16:56:40 INFO - Starting resource monitoring. 16:56:40 INFO - ##### 16:56:40 INFO - ##### Finished create-virtualenv step (success) 16:56:40 INFO - ##### 16:56:40 INFO - ##### 16:56:40 INFO - ##### Running install step. 16:56:40 INFO - ##### 16:56:40 INFO - Running pre-action listener: _resource_record_pre_action 16:56:40 INFO - Running main action method: install 16:56:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:40 INFO - Reading from file tmpfile_stdout 16:56:40 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:40 INFO - Reading from file tmpfile_stdout 16:56:40 INFO - Output received: 16:56:40 INFO - Usage: mozinstall [options] installer 16:56:40 INFO - Options: 16:56:40 INFO - -h, --help show this help message and exit 16:56:40 INFO - -d DEST, --destination=DEST 16:56:40 INFO - Directory to install application into. [default: 16:56:40 INFO - "/builds/slave/test"] 16:56:40 INFO - --app=APP Application being installed. [default: firefox] 16:56:40 INFO - mkdir: /builds/slave/test/build/application 16:56:40 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'] 16:56:40 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 16:56:57 INFO - Reading from file tmpfile_stdout 16:56:57 INFO - Output received: 16:56:57 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:57 INFO - Running post-action listener: _resource_record_post_action 16:56:57 INFO - ##### 16:56:57 INFO - ##### Finished install step (success) 16:56:57 INFO - ##### 16:56:57 INFO - ##### 16:56:57 INFO - ##### Running run-tests step. 16:56:57 INFO - ##### 16:56:57 INFO - Running pre-action listener: _resource_record_pre_action 16:56:57 INFO - Running main action method: run_tests 16:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:57 INFO - Python 2.7.3 16:56:57 INFO - Return code: 0 16:56:57 INFO - grabbing minidump binary from tooltool 16:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:56:57 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 0x1e3e3b0>, '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 0x1e3f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e3f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:57 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 16:56:57 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 16:56:57 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 16:56:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:57 INFO - Return code: 0 16:56:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 16:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 16:56:57 INFO - Using env: {'DISPLAY': ':0', 16:56:57 INFO - 'HOME': '/home/cltbld', 16:56:57 INFO - 'LANG': 'en_US.UTF-8', 16:56:57 INFO - 'LANGUAGE': 'en_US:en', 16:56:57 INFO - 'LOGNAME': 'cltbld', 16:56:57 INFO - 'MAIL': '/var/mail/cltbld', 16:56:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:57 INFO - 'MOZ_NO_REMOTE': '1', 16:56:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:57 INFO - 'NO_EM_RESTART': '1', 16:56:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:57 INFO - 'PWD': '/builds/slave/test', 16:56:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:57 INFO - 'SHELL': '/bin/bash', 16:56:57 INFO - 'SHLVL': '1', 16:56:57 INFO - 'TERM': 'linux', 16:56:57 INFO - 'TMOUT': '86400', 16:56:57 INFO - 'USER': 'cltbld', 16:56:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870', 16:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:57 INFO - '_': '/tools/buildbot/bin/python'} 16:56:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 16:56:57 INFO - mozversion application_buildid: 20160629143024 16:56:57 INFO - mozversion application_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 16:56:57 INFO - mozversion application_display_name: Nightly 16:56:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:57 INFO - mozversion application_name: Firefox 16:56:57 INFO - mozversion application_remotingname: firefox 16:56:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:56:57 INFO - mozversion application_vendor: Mozilla 16:56:57 INFO - mozversion application_version: 50.0a1 16:56:57 INFO - mozversion platform_buildid: 20160629143024 16:56:57 INFO - mozversion platform_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 16:56:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:56:57 INFO - mozversion platform_version: 50.0a1 16:56:57 INFO - using testdate: 1467244617 16:56:57 INFO - actual date: 1467244617 16:56:57 INFO - starting webserver on 'localhost:60243' 16:56:57 INFO - SUITE-START | Running 2 tests 16:56:57 INFO - TEST-START | dromaeo_css 16:56:57 INFO - operating with platform_type : linux_ 16:56:57 INFO - Initialising browser for dromaeo_css test... 16:56:57 INFO - TEST-INFO | started process 3433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypCKBt/profile http://localhost:60243/getInfo.html) 16:57:03 INFO - PROCESS | 3433 | __metrics Screen width/height:1600/1200 16:57:03 INFO - PROCESS | 3433 | colorDepth:24 16:57:03 INFO - PROCESS | 3433 | Browser inner width/height: 1024/697 16:57:03 INFO - PROCESS | 3433 | __metrics 16:57:03 ERROR - PROCESS | 3433 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:57:04 INFO - TEST-INFO | 3433: exit 0 16:57:04 INFO - Browser initialized. 16:57:04 INFO - Running cycle 1/1 for dromaeo_css test... 16:57:04 INFO - TEST-INFO | started process 3553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypCKBt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:16 INFO - PROCESS | 3553 | RSS: Main: 168931328 16:57:16 INFO - PROCESS | 3553 | 16:58:06 INFO - PROCESS | 3553 | 1467244686277 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] 17:00:14 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:60243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60243/tests/dromaeo/cssquery-ext.html) 17:00:15 INFO - PROCESS | 3553 | RSS: Main: 172388352 17:00:15 INFO - PROCESS | 3553 | 17:03:17 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:60243/tests/dromaeo/cssquery-ext.html (next: http://localhost:60243/tests/dromaeo/cssquery-jquery.html) 17:03:18 INFO - PROCESS | 3553 | RSS: Main: 169115648 17:03:18 INFO - PROCESS | 3553 | 17:06:20 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:60243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60243/tests/dromaeo/cssquery-mootools.html) 17:06:21 INFO - PROCESS | 3553 | RSS: Main: 172900352 17:06:21 INFO - PROCESS | 3553 | 17:09:22 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:60243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60243/tests/dromaeo/cssquery-prototype.html) 17:09:23 INFO - PROCESS | 3553 | RSS: Main: 167804928 17:09:23 INFO - PROCESS | 3553 | 17:12:25 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:60243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60243/tests/dromaeo/cssquery-yui.html) 17:12:26 INFO - PROCESS | 3553 | RSS: Main: 170373120 17:12:26 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:60243/tests/dromaeo/cssquery-yui.html (next: http://localhost:60243/tests/dromaeo/cssquery-dojo.html) 17:15:29 INFO - PROCESS | 3553 | RSS: Main: 171270144 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | __start_tp_report 17:15:29 INFO - PROCESS | 3553 | _x_x_mozilla_page_load 17:15:29 INFO - PROCESS | 3553 | _x_x_mozilla_page_load_details 17:15:29 INFO - PROCESS | 3553 | |i|pagename|runs| 17:15:29 INFO - PROCESS | 3553 | |0;dojo.html;3090.39737251236;3141.8114913105214;3166.6358368787583;3196.1530194498478;3201.9359612807743;5355.839324820252;5356.866078348044;5384.946150538493;5480.424555421683;5538.778448862041;5367.2485851980755;5470.452954704528;5531.861703457415;5594.9720251398685;5617.466340697637;4917.016596680669;4927.408710954691;4942.752862356886;5071.340725705653;5127.205283181094;4931.630127740415;5082.466341034194;5118.232265160219;5132;5133.512316329943;4888.877778055541;4936.753162341868;4958.578520825734;4992.925106123411;5001.8499445016705;4964.1809101498575;4978.726170060645;4981.526754958273;4983.90032199354;5019.974900125476;4920.901581968376;4945.67853089548;4951.529604687549;4959.132151873444;4985.950140498621;5289.629725919187;5352.090144675376;5418.431064738185;5463.098588732854;5509;5902.704864756745;5902.937471255173;5906.497947674453;5917.585768996172;5918.40815918409;5756.424357564252;5959.940400596025;5960.701964901781;5960.97019514904;5971.761129554812;5434.565234781208;5456.536194423479;5503.3120859892515;5531.2809334787025;5534.1975413564805;5998.130271110752;6004.489618382487;6031.035034394476;6037.758489660365;6040.244969378828;5605.990921634064;5724.513416359656;5736.397678243808;5748;5753.194552762617;5839.386864379264;5922.052471604523;5922.615030023035;5925.140854576149;5987.371326010706;5641.887162256732;5773.769049238067;5827.59206855516;5906.911396329058;5912.408759124053;5685.260916080883;5764.193012978187;5820;5859.472647461749;5871.794487193013;4475.9552404475535;4499.977500112478;4504.2793153095345;4544.977275113603;4561.863144105682;3946.5856085111222;3951.3677811550015;3967.107400834847;3970.8610198643487;3974.5627980922077;5498.367687715884;5502.257195278587;5556.333240011144;5571.303587051619;5602.439756024365;5838.2702162229725;5912.142739302777;5915.201447804578;5919.052951527735;5969.970150149222;5549.472800083986;5564.360098588633;5593;5600.215969764155;5602.38373778884;5002.774875130555;5043.924341134886;5079.8984020319385;5092.108880945893;5095.541401273903;6120.447133218794;6123.252510653108;6125.082842094287;6136.507825496156;6141.977005061692;5910.320313163869;5912.526997840248;5912.645241285537;5913.526917846476;5969.194158788508;5877.324107727666;6058.787942421994;6073.271207455134;6112.663803490851;6123.8469038272615;5773.538116950718;5790.363060063305;5807.925533776096;5810.389909059657;5818.214541036906;5860.8571328590515;5905.261842269716;5916.112583112567;5916.171735956884;5921.3190483094995;5527.474889885454;5612.7754889803955;5654.830355089354;5688.374278829243;5705.828825135252;5676.971615141898;5690.544756419559;5692.231548740867;5698.857528561653;5744.339400968942;5606.85982850432;5613.691246981455;5621.184928185308;5634.464725851038;5669.177969194361;5621.606487545832;5621.662700237999;5638.830835074954;5727.513161381163;5806.216160818235;5593.384727680033;5619.325680918316;5622.493975542221;5624.465675760796;5651.745671444713 17:15:29 INFO - PROCESS | 3553 | |1;ext.html;568.9772409103637;604.9364816694247;606.8058221369163;631.1258906414618;680.9659517024147;37876;42793.93015174626;42795.144097118115;42811.78594107033;42825;40281.19437611246;40923.386149207785;41015;41034.79482602583;41052.17895642085;8734.606942687578;8888.06675299094;8899.733008009738;8903.777405564848;8942.41874278173;8858.689945851896;8911.242544383702;8918.598663060178;8918.73243802687;8938.329625278098;9001.369904106716;9009.684661036865;9020.54897255138;9027.368084234105;9030;8973.730788076367;8977.685780997634;9002.549872506414;9007.324450666227;9011.143941325563;8685.782855428602;8815.867761983576;8853.424527405698;8882.067382924764;8893.4663920165;33862.661373386196;40725;41122.38316425256;41136.58863411358;41167.176656467;3248.13924310058;3260.673932606744;3493.2140268439653;3648.4344926536164;4035.3139966205817;30114.397712045855;30515.847420762977;30533.236669083228;30673.539896901566;30937;4206;4269.807858646368;4288.120935208275;4357.760323182224;4431.091626216617;308772;310027;310274;310275;311526;35749;36396.636033639326;36415.453768193496;36447;36448.08879778027;37094.44358334627;39417;40150.397744033864;40208.19583608311;40334.1933161341;16525.25636346367;16592.668146637;16673.49979500617;16685;16821.91589042047;13730.313484325743;13751.862481375258;13759.38082786277;13761.036727429184;13852.238126902916;19402.8059719401;19578.021098944995;19611.234988851073;19615;19687;7128.501004929709;7285.526440781332;7421.765716797916;7484.625768711543;7559.470837041355;955.6702937486556;1082.7130810335268;1088.7006073329899;1097.3032124600936;1109.3454861631515;32527.512087318708;32636.18409539733;32692.182695432806;32857.67142328594;32887.61572467932;1138.0952143046297;1173.4250217393417;1182.6097387862158;1196.5692350753723;1259.5906330442642;17226.655466890592;17398.56503587395;17960.910195448938;18016.819831801775;18644.16101275446;566319;797996;798838;800689;804170;59077.40922590719;59431.10853337203;59820;59916;60083.399166008654;1387.6045327081733;1421.2183299185613;1426.187073368191;1426.493594773861;1434.9497767578293;30908.536371954888;32796.67203327936;33122.66877331292;33140.33719325552;33341;49453.50546494489;50002;50381.49618503915;50419.49580504148;50425.747871260406;500980;507525;511586;512559;513762;29141.125766227047;29188.708112918597;29194.270143246587;29484.85257573784;29500.704992950654;46574.76712616415;47383.28925066058;47385;48302.51697483121;48530.27204591863;40080;40225.798871005456;40432.79783601063;40615.79692101521;40826;40560.1887962245;40575.1884962305;40584;40695.79652101839;41382.172356552095;34309.82845085759;38898.80550597229;39704;39829.80085099556;40309;35388.292234155684;36761.448578270814;36830;37378.8131059343;37463.81268093642;27590;28220.717792821808;28400;28550.85724571364;28703.282417939718 17:15:29 INFO - PROCESS | 3553 | |2;jquery.html;406.835231731149;410.64299352790965;415.12823071549747;420.16177725437745;424.35074336265524;18784.248630054797;19992.5001874953;20217.494562635922;20522.589548209027;21261.14955401786;19328.130234139462;19559.511012224702;19857.70213446796;19969.800301997013;20110.195592176296;5769.653820770746;5865.061590145578;5967.940320596782;6006.978813601676;6093.268807743077;5860.794872179475;5884.764609415618;5902.409759024106;5932.466078052975;5968.343482216975;5764.769409223626;5863.58954873159;5867.794627188049;5926;5976.462118409342;5804.825855224329;5901.586888917777;5902.468777809996;5958.344582095966;5972.9701351493395;5239.266502689627;5287.841364759063;5303.5226829585135;5352.973235133838;5357.946420535784;19330.710039349422;19834.504137396536;23720;23865;24199.879000605062;2405.446747248125;2496.6379874918034;2626.3171575390347;2635.894564217429;2669.706332303445;14783.852161478462;15118.848811511854;15403.691926161415;15474.148921809296;15564.14397208153;1986.6721990871488;2055.825254853339;2081.9375418737463;2082.562661841;2115.947101322464;84818.57590712068;85475.57262213712;85926.14073859244;86654;87088.12911870927;11239.157063220291;11280.097592192606;11371.658850234506;11430;11815.11386646005;15832.60418489547;15873;15997.440089596808;16008.759868601981;16036.198190090683;8255.091939886608;8321.833563328699;8500.532470714046;8625.525596092275;8651.480911145225;8240.258376746122;8344.457610255315;8366.121557236402;8425.272819072075;8707.172818582225;6690.632015239111;6746.392824645805;6819.965900170468;6909.516333856582;6919;1988.8862237147243;2024.7266619006245;2038.9694154587396;2051.3845846246068;2057.8270385880205;986.6990567876867;992.6277645882794;1006.0593345222094;1014.3710899242517;1055.7096798380353;20441.182352705724;21129.7280025563;21180.682289765668;21208.681869771965;21452.24917127893;1040.3237895368072;1047.4814966591587;1063.6011495689118;1133.2067552713133;1139.1058019454688;11322.60370887015;11818.40907954616;11997.340146292037;12035.699107522381;12094.516219351128;366966;368036;368529;507073;513164;62957.37042629607;102697.45953810698;103398;103893;106841.46579267054;1014.7868947521104;1047.272145858621;1056.772793849326;1073.742301847551;1087.1846115413439;18741.437756867315;18915.243390264237;19584.8041519583;19662.311819086837;19710.043493476092;44045.483536633874;44788.55211447974;45153;46427.76786116048;46956.06087878155;64267.67866160639;66278.33721662722;66833.66583167053;67335;67885.66057169682;8757.737267881974;8863.689770857989;8901.065388134153;8987.550622468982;9120.361574689709;13903.026788124735;14273.006912385443;14309.069910455786;14399.712005760035;14553.19957402353;12634.557790477656;12670.619881403572;12721.491140354283;12768.042396820461;12902.806457903327;12085.15403921717;12523.37383130858;12548.24710517372;12760.979121670058;12802.039847011325;12642.683932901751;12729.172603781095;12807.487700491876;12859.678508037;12925.935370323088;8719.34604904622;8774.780630484289;8883.756274121757;8964.238039766693;9243.537823108953;8796.208341249063;11769.764604708029;12560.811587826007;12714.11001229905;12890.29103399322 17:15:29 INFO - PROCESS | 3553 | |3;mootools.html;1358.755424023676;1423.9644008899777;1501.2943916359307;1787.955301117472;1796.1827368547313;7848.372130229583;8640.179182977623;8802.383833131684;9136.314776391764;9139.405938613994;8837.293016558677;8865.335099867503;8941.86587201191;8948.194662480391;8963.596638151283;2375.58427275227;2412.7345991940874;2417.8428402153804;2421.878906054699;2423.7939775119135;2347.4366152123453;2387.462820865309;2434.440078781872;2434.671319371889;2443.9389015274583;2346.8826558672085;2380.6310021946624;2395.9760402396014;2398.0887262840097;2410.1564452441594;2327.615943369342;2341.484873327865;2357.5167090746354;2358.84667496613;2371.822113341489;2328.1734984080745;2341.812654987597;2342.5900467418132;2345.6129738593113;2356.611159158737;9036.638534458614;9084.909150908472;9087.454752714859;9148.725538233864;9169.312301577342;5292.576593872481;5390.0836857734275;5395.3525576931015;5419.34967803866;5420.24116623673;3504.5794504659602;3518.2963407318384;3529.347070791886;3581.247937933037;3658.0854786303425;1159.0437888741737;1173.290159453527;1199.7000749812546;1205.9397030148457;1212.6059030814931;12625.24248545081;12636.873631263661;12680.239185648798;12688.492460301577;12704;4496.752678602643;4666.440027196758;4737.265723812815;4762.571368576845;4791.904161916812;10526.473676316153;10528;10538.051575358255;10554.208434367452;10575.788484230272;5224.582033437316;5242.842714718565;5257.868553286198;5289.206619007103;5310.628256022119;4431.623312018514;4877.6585639004925;4878.43897951733;5029.2958985742025;5035.370578677665;4103.774292413946;4129.772862492532;4172.4784401949755;4192.431301228207;4193.958060419418;1289.8839104480642;1290.3096843188848;1295.371744703818;1298.6623477895814;1308.3065975033248;857.8970523537215;971.2327261463506;973.3332667123043;977.4770497783652;979.86771785808;5935.228420305419;5954.940450595439;5959.046552551657;5975.67133807636;6042.244719410074;413;416.2465936654665;420.6550628484674;420.86532309661226;440.6893140336055;3927.430522574268;3978.264021156095;4036.414719865603;4050.10897602527;4060.715749897479;11070.778584428266;11204.271722338022;11256;11262.887371126348;11342.262752921033;10474.68575942723;10975.780484390267;11215.551377944954;11273.661790146145;11275.097992160772;8417.368697347601;8518.105598912025;8557.229849313717;8628.52543110135;8632.525211113449;5959.404059594006;6096.542759292982;6225.750969961332;6236.376362363909;6327.778527751507;9914.652987145415;10127.848082278919;10359.689209323733;10443.94778026105;10569.365838049742;10440.947795260976;10474.842877356694;10619.575216991234;10743.46282685847;10752.569897204337;7427.331540161412;7909.129995700353;8050.5169689818795;8110.553919534483;8218.547979861165;8950.23922966555;8960.238379737535;8994;9051.818963620559;9061.456312621263;7714.5756983366455;7944.768352146434;8099.716509922125;8123.268905798506;8240.340772738047;7949.602519873867;8025.678972841254;8058.315043221158;8084.110747817617;8126.959365203136;6838.897416538656;7068.858622827617;7193.892091618525;7252.093488313961;7282.089738782653;4979.452260251297;5026.472220416804;5165.560927321219;5193.76628051731;5254.894902102013;4984.900301993867;5113.53978141969;5192.27308176848;5245.868853278546;5342.252084708066 17:15:29 INFO - PROCESS | 3553 | |4;prototype.html;324.6737029285568;326.1991810106189;329.3692578711768;329.8499182871795;330.7337593237446;5631.549476041917;5721.31344238692;5728.25532680752;5733.136730562568;5744.913826292609;5539.529140023093;5601.80393686221;5606.831795046155;5621.8032368867;5650.9152362714485;4140.515690585639;4181.393697913801;4329.67527435442;4346.717973064151;4349.913001739963;4311.1808756336195;4339.761313127777;4343.087951530167;4355.390245365651;4364.25807612705;4328.177646247219;4341.500727416356;4362.6727995400315;4364.825406983733;4366.820958341246;4227.328801674152;4253.361995700654;4318.956810431919;4319.870403887889;4329.805158767832;3772.622737726233;3773.2830762155377;3774.698024158088;3777.660010599059;3786.583475817658;5424.945750542483;5459;5465.371482279549;5473.31583552056;5476.424975377608;4856.344393506866;4929.260610908356;4944.629152813517;4946.3817022872145;4947.381577302837;5838.562107841886;5871.442212989802;5883.23517942669;5885.705714714247;5899.764009439617;4190.057237121654;4195.244855925932;4208.831646734127;4224.134052519226;4224.894377640553;5893.675847828367;6141.662208578527;6170.7531698732;6188.938110618881;6208.782692605782;4231.174920890458;4241.681873859473;4259.680523960716;4267.146570685875;4287.485501739811;4291.120320334324;4314.158739045856;4319.67602429819;4324.113556720865;4333.544977777288;4842.612590992712;4931.5315045070665;4932.150443583656;4997.800527873284;5004.924926126111;5887.4398284454655;5890.558208134407;5898;5899.793507227227;5925.170476133345;1494.4619936822735;1507.3895072495657;1515.4392874636235;1519.9088054716754;1523.2231561903288;931.6785708930408;959.3284700709531;990.4700984973005;993.6919554937992;1001.4792307999945;5735.885282294331;5747.339056008529;5758.7696492140685;5798.9130163047585;5828.591998560145;6068.271807383054;6100.084987251859;6102.72537735803;6115.388461153938;6127.571070025145;5524.5139687140945;5667.263255776723;5741.96644603967;5750.741216645261;5761.5102716269585;3212.554350542265;3218.2115381731624;3223.8065716056644;3243.918902027421;3246.886358977472;6037.879242415127;6190.1952746142715;6193.504519638508;6246.406591373812;6385.808425747142;6206.627602343783;6212.81361559154;6223.657698826518;6229.691764729367;6276.46650034743;6135.96932015346;6234.812955611339;6252.906206406908;6270.529710271748;6282.246130464282;6152.5082341651705;6154.815355539341;6170.197874276495;6217.626942383471;6246.46905013079;6092.756289748538;6115.174451448997;6160;6174.25908890936;6179.598326108969;6272.717727702173;6389.201349831271;6407.8718425630295;6415.9358406417205;6437.969924812008;4265.808038638207;4296.6347860432215;4303.096349766584;4306.784660767012;4317.0934103838545;5933.495652869555;6035.336113027652;6159.384061593805;6209.906851397142;6224.626522408489;5922.460160358251;5925;5949;5954.46409823118;5968.403159683997;5723.969685456491;5856.209411729533;5904.498117660047;5930;5960.5231581474245;5785.739641716217;5803.390643982321;5833.008388573868;5837.824865254049;5842.824715258549;5947.613405128653;5949.553783466344;5975.910361344497;5976.462118409364;5996.67018313997;5548.611597188158;5766.4233576642;5849.444302791228;5849.883002339844;5858.7070646468355 17:15:29 INFO - PROCESS | 3553 | |5;yui.html;762.645369902995;784.6743601405417;829.5520418973753;847.0555330806153;852.5609311204729;13810.309484525771;14596.562103136896;14872.405103795862;14875.404983800649;14993.17537535435;13843.653908652288;14078.366473508717;14090.225037622953;14100.506482273122;14121.85878141221;673.6328700858044;787.3425689549233;814.4543156085437;818.0592318833329;819.315871247509;784.6782819044194;810.1857633078747;811.0146172400532;812.1796985045117;814.7963009247688;868.0885070675797;871.2333146830812;874.4316194473611;875.4309698695866;878.056089703568;865.0830120072743;866.4151697604156;867.4405008769371;872.2367928062945;872.62477134832;630.9495240380759;633.5153607490273;633.6103296472636;635.5836926812945;638.2245571630491;14299.499517516837;14318.427262909576;14359;14362.420133785276;14400.63998400038;15703.136327501983;15705.136217508032;15903.60240993973;15963.600909977227;16090.5977350566;12033.939830300793;12171.513139474411;12211.511539538496;12265.080118991022;12724.809127863089;3898.2593307271527;3941.2511622791576;3967.226390853785;4041.6564592009713;4050.0887300357476;75261.62369188119;75484.62257688731;75514;75576;75702.24297757063;11871;11941.147415844773;11976.221545599683;12003.939980300218;12143.817842732366;23345.182918597766;23364;23377.649335259986;23436.64845027326;23492.882535587214;7921.801954951173;8132;8211.876821847676;8286.917130828615;8298.377621678399;4565.474970378383;4861.440934292602;4925.433575138905;4949.90100197994;4973.801047958041;3434.364642541138;3544.025393016889;3547.095490649919;3549.378858699769;3557.3063252665997;597.6593341795135;597.8271663786707;610.4018062298971;612.2866860107924;613.8342647485154;659.6273105695267;672.9596224226563;699.3076853914689;701.7719241246615;706.477206866925;9174.954125229464;9722.222222222204;9972.202223822076;10035;10089.495525223856;780.594091072639;793.4525177627419;795.7572940253278;804.6379129391797;830.8451252758671;4400.22995975703;4538.750368729686;4542.977285113553;4550.522195169526;4604.700694454849;113582.43208783903;115744.42127789475;115891.42054289674;115920.42039789916;116802;100329;100730.49634751926;100947.49526252321;101158.49420752849;101924.49037754913;56702;88130.11869881219;90402;91946;93701.99999999863;8769.605367758339;8876.822463550821;8933.419327743675;9067;9188.081191880758;50378.49621503738;50450.495495046045;50978;52300.73849630728;52337.738311309724;71655.28344716487;76339;76467.61766191134;77422.61288693521;79749;11776.941115294369;12126.333051682243;12177.208481448677;12362.258264503798;12553.309567973849;13116.934415327862;14022.509212177933;14048.157110573398;14220.288985550475;14511.564653060424;12397.380130993595;12499;12682.048846336376;12795.104342696295;12981.221126732426;12710.237385756884;12780.61658150257;12882.549110781078;12904.870951290366;13321.467141314239;12779.898439865536;13385.933070334586;13422.127561708849;13542.187468751512;13855.850209175753;10418.843717344398;10867.886938114805;10921.344719316867;10922.836157457803;11436.701550176222;10110.545025474019;10154.672834306248;10798.892011079788;10900.370612600678;10980.1215902726 17:15:29 INFO - PROCESS | 3553 | __end_tp_report 17:15:29 INFO - PROCESS | 3553 | __start_cc_report 17:15:29 INFO - PROCESS | 3553 | _x_x_mozilla_cycle_collect,389 17:15:29 INFO - PROCESS | 3553 | __end_cc_report 17:15:29 INFO - PROCESS | 3553 | __startTimestamp1467245729528__endTimestamp 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | ------- Summary: start ------- 17:15:29 INFO - PROCESS | 3553 | Number of tests: 6 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | [#0] dojo.html Cycles:165 Average:5446.32 Median:5621.18 stddev:623.78 (11.1%) stddev-sans-first:597.68 17:15:29 INFO - PROCESS | 3553 | Values: 3090.4 3141.8 3166.6 3196.2 3201.9 5355.8 5356.9 5384.9 5480.4 5538.8 5367.2 5470.5 5531.9 5595.0 5617.5 4917.0 4927.4 4942.8 5071.3 5127.2 4931.6 5082.5 5118.2 5132.0 5133.5 4888.9 4936.8 4958.6 4992.9 5001.8 4964.2 4978.7 4981.5 4983.9 5020.0 4920.9 4945.7 4951.5 4959.1 4986.0 5289.6 5352.1 5418.4 5463.1 5509.0 5902.7 5902.9 5906.5 5917.6 5918.4 5756.4 5959.9 5960.7 5961.0 5971.8 5434.6 5456.5 5503.3 5531.3 5534.2 5998.1 6004.5 6031.0 6037.8 6040.2 5606.0 5724.5 5736.4 5748.0 5753.2 5839.4 5922.1 5922.6 5925.1 5987.4 5641.9 5773.8 5827.6 5906.9 5912.4 5685.3 5764.2 5820.0 5859.5 5871.8 4476.0 4500.0 4504.3 4545.0 4561.9 3946.6 3951.4 3967.1 3970.9 3974.6 5498.4 5502.3 5556.3 5571.3 5602.4 5838.3 5912.1 5915.2 5919.1 5970.0 5549.5 5564.4 5593.0 5600.2 5602.4 5002.8 5043.9 5079.9 5092.1 5095.5 6120.4 6123.3 6125.1 6136.5 6142.0 5910.3 5912.5 5912.6 5913.5 5969.2 5877.3 6058.8 6073.3 6112.7 6123.8 5773.5 5790.4 5807.9 5810.4 5818.2 5860.9 5905.3 5916.1 5916.2 5921.3 5527.5 5612.8 5654.8 5688.4 5705.8 5677.0 5690.5 5692.2 5698.9 5744.3 5606.9 5613.7 5621.2 5634.5 5669.2 5621.6 5621.7 5638.8 5727.5 5806.2 5593.4 5619.3 5622.5 5624.5 5651.7 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | [#1] ext.html Cycles:180 Average:65850.39 Median:40295.10 stddev:149947.29 (372.1%) stddev-sans-first:150287.82 17:15:29 INFO - PROCESS | 3553 | Values: 569.0 604.9 606.8 631.1 681.0 37876.0 42793.9 42795.1 42811.8 42825.0 40281.2 40923.4 41015.0 41034.8 41052.2 8734.6 8888.1 8899.7 8903.8 8942.4 8858.7 8911.2 8918.6 8918.7 8938.3 9001.4 9009.7 9020.5 9027.4 9030.0 8973.7 8977.7 9002.5 9007.3 9011.1 8685.8 8815.9 8853.4 8882.1 8893.5 33862.7 40725.0 41122.4 41136.6 41167.2 3248.1 3260.7 3493.2 3648.4 4035.3 30114.4 30515.8 30533.2 30673.5 30937.0 4206.0 4269.8 4288.1 4357.8 4431.1 308772.0 310027.0 310274.0 310275.0 311526.0 35749.0 36396.6 36415.5 36447.0 36448.1 37094.4 39417.0 40150.4 40208.2 40334.2 16525.3 16592.7 16673.5 16685.0 16821.9 13730.3 13751.9 13759.4 13761.0 13852.2 19402.8 19578.0 19611.2 19615.0 19687.0 7128.5 7285.5 7421.8 7484.6 7559.5 955.7 1082.7 1088.7 1097.3 1109.3 32527.5 32636.2 32692.2 32857.7 32887.6 1138.1 1173.4 1182.6 1196.6 1259.6 17226.7 17398.6 17960.9 18016.8 18644.2 566319.0 797996.0 798838.0 800689.0 804170.0 59077.4 59431.1 59820.0 59916.0 60083.4 1387.6 1421.2 1426.2 1426.5 1434.9 30908.5 32796.7 33122.7 33140.3 33341.0 49453.5 50002.0 50381.5 50419.5 50425.7 500980.0 507525.0 511586.0 512559.0 513762.0 29141.1 29188.7 29194.3 29484.9 29500.7 46574.8 47383.3 47385.0 48302.5 48530.3 40080.0 40225.8 40432.8 40615.8 40826.0 40560.2 40575.2 40584.0 40695.8 41382.2 34309.8 38898.8 39704.0 39829.8 40309.0 35388.3 36761.4 36830.0 37378.8 37463.8 27590.0 28220.7 28400.0 28550.9 28703.3 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | [#2] jquery.html Cycles:180 Average:28348.58 Median:21234.92 stddev:71682.44 (337.6%) stddev-sans-first:71852.83 17:15:29 INFO - PROCESS | 3553 | Values: 406.8 410.6 415.1 420.2 424.4 18784.2 19992.5 20217.5 20522.6 21261.1 19328.1 19559.5 19857.7 19969.8 20110.2 5769.7 5865.1 5967.9 6007.0 6093.3 5860.8 5884.8 5902.4 5932.5 5968.3 5764.8 5863.6 5867.8 5926.0 5976.5 5804.8 5901.6 5902.5 5958.3 5973.0 5239.3 5287.8 5303.5 5353.0 5357.9 19330.7 19834.5 23720.0 23865.0 24199.9 2405.4 2496.6 2626.3 2635.9 2669.7 14783.9 15118.8 15403.7 15474.1 15564.1 1986.7 2055.8 2081.9 2082.6 2115.9 84818.6 85475.6 85926.1 86654.0 87088.1 11239.2 11280.1 11371.7 11430.0 11815.1 15832.6 15873.0 15997.4 16008.8 16036.2 8255.1 8321.8 8500.5 8625.5 8651.5 8240.3 8344.5 8366.1 8425.3 8707.2 6690.6 6746.4 6820.0 6909.5 6919.0 1988.9 2024.7 2039.0 2051.4 2057.8 986.7 992.6 1006.1 1014.4 1055.7 20441.2 21129.7 21180.7 21208.7 21452.2 1040.3 1047.5 1063.6 1133.2 1139.1 11322.6 11818.4 11997.3 12035.7 12094.5 366966.0 368036.0 368529.0 507073.0 513164.0 62957.4 102697.5 103398.0 103893.0 106841.5 1014.8 1047.3 1056.8 1073.7 1087.2 18741.4 18915.2 19584.8 19662.3 19710.0 44045.5 44788.6 45153.0 46427.8 46956.1 64267.7 66278.3 66833.7 67335.0 67885.7 8757.7 8863.7 8901.1 8987.6 9120.4 13903.0 14273.0 14309.1 14399.7 14553.2 12634.6 12670.6 12721.5 12768.0 12902.8 12085.2 12523.4 12548.2 12761.0 12802.0 12642.7 12729.2 12807.5 12859.7 12925.9 8719.3 8774.8 8883.8 8964.2 9243.5 8796.2 11769.8 12560.8 12714.1 12890.3 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | [#3] mootools.html Cycles:180 Average:5930.39 Median:4581.60 stddev:3417.04 (74.6%) stddev-sans-first:3409.35 17:15:29 INFO - PROCESS | 3553 | Values: 1358.8 1424.0 1501.3 1788.0 1796.2 7848.4 8640.2 8802.4 9136.3 9139.4 8837.3 8865.3 8941.9 8948.2 8963.6 2375.6 2412.7 2417.8 2421.9 2423.8 2347.4 2387.5 2434.4 2434.7 2443.9 2346.9 2380.6 2396.0 2398.1 2410.2 2327.6 2341.5 2357.5 2358.8 2371.8 2328.2 2341.8 2342.6 2345.6 2356.6 9036.6 9084.9 9087.5 9148.7 9169.3 5292.6 5390.1 5395.4 5419.3 5420.2 3504.6 3518.3 3529.3 3581.2 3658.1 1159.0 1173.3 1199.7 1205.9 1212.6 12625.2 12636.9 12680.2 12688.5 12704.0 4496.8 4666.4 4737.3 4762.6 4791.9 10526.5 10528.0 10538.1 10554.2 10575.8 5224.6 5242.8 5257.9 5289.2 5310.6 4431.6 4877.7 4878.4 5029.3 5035.4 4103.8 4129.8 4172.5 4192.4 4194.0 1289.9 1290.3 1295.4 1298.7 1308.3 857.9 971.2 973.3 977.5 979.9 5935.2 5954.9 5959.0 5975.7 6042.2 413.0 416.2 420.7 420.9 440.7 3927.4 3978.3 4036.4 4050.1 4060.7 11070.8 11204.3 11256.0 11262.9 11342.3 10474.7 10975.8 11215.6 11273.7 11275.1 8417.4 8518.1 8557.2 8628.5 8632.5 5959.4 6096.5 6225.8 6236.4 6327.8 9914.7 10127.8 10359.7 10443.9 10569.4 10440.9 10474.8 10619.6 10743.5 10752.6 7427.3 7909.1 8050.5 8110.6 8218.5 8950.2 8960.2 8994.0 9051.8 9061.5 7714.6 7944.8 8099.7 8123.3 8240.3 7949.6 8025.7 8058.3 8084.1 8127.0 6838.9 7068.9 7193.9 7252.1 7282.1 4979.5 5026.5 5165.6 5193.8 5254.9 4984.9 5113.5 5192.3 5245.9 5342.3 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | [#4] prototype.html Cycles:180 Average:4976.43 Median:5743.44 stddev:1489.20 (25.9%) stddev-sans-first:1451.87 17:15:29 INFO - PROCESS | 3553 | Values: 324.7 326.2 329.4 329.8 330.7 5631.5 5721.3 5728.3 5733.1 5744.9 5539.5 5601.8 5606.8 5621.8 5650.9 4140.5 4181.4 4329.7 4346.7 4349.9 4311.2 4339.8 4343.1 4355.4 4364.3 4328.2 4341.5 4362.7 4364.8 4366.8 4227.3 4253.4 4319.0 4319.9 4329.8 3772.6 3773.3 3774.7 3777.7 3786.6 5424.9 5459.0 5465.4 5473.3 5476.4 4856.3 4929.3 4944.6 4946.4 4947.4 5838.6 5871.4 5883.2 5885.7 5899.8 4190.1 4195.2 4208.8 4224.1 4224.9 5893.7 6141.7 6170.8 6188.9 6208.8 4231.2 4241.7 4259.7 4267.1 4287.5 4291.1 4314.2 4319.7 4324.1 4333.5 4842.6 4931.5 4932.2 4997.8 5004.9 5887.4 5890.6 5898.0 5899.8 5925.2 1494.5 1507.4 1515.4 1519.9 1523.2 931.7 959.3 990.5 993.7 1001.5 5735.9 5747.3 5758.8 5798.9 5828.6 6068.3 6100.1 6102.7 6115.4 6127.6 5524.5 5667.3 5742.0 5750.7 5761.5 3212.6 3218.2 3223.8 3243.9 3246.9 6037.9 6190.2 6193.5 6246.4 6385.8 6206.6 6212.8 6223.7 6229.7 6276.5 6136.0 6234.8 6252.9 6270.5 6282.2 6152.5 6154.8 6170.2 6217.6 6246.5 6092.8 6115.2 6160.0 6174.3 6179.6 6272.7 6389.2 6407.9 6415.9 6438.0 4265.8 4296.6 4303.1 4306.8 4317.1 5933.5 6035.3 6159.4 6209.9 6224.6 5922.5 5925.0 5949.0 5954.5 5968.4 5724.0 5856.2 5904.5 5930.0 5960.5 5785.7 5803.4 5833.0 5837.8 5842.8 5947.6 5949.6 5975.9 5976.5 5996.7 5548.6 5766.4 5849.4 5849.9 5858.7 17:15:29 INFO - PROCESS | 3553 | 17:15:29 INFO - PROCESS | 3553 | [#5] yui.html Cycles:180 Average:20773.63 Median:4045.87 stddev:30171.93 (745.7%) stddev-sans-first:30219.15 17:15:29 INFO - PROCESS | 3553 | Values: 762.6 784.7 829.6 847.1 852.6 13810.3 14596.6 14872.4 14875.4 14993.2 13843.7 14078.4 14090.2 14100.5 14121.9 673.6 787.3 814.5 818.1 819.3 784.7 810.2 811.0 812.2 814.8 868.1 871.2 874.4 875.4 878.1 865.1 866.4 867.4 872.2 872.6 630.9 633.5 633.6 635.6 638.2 14299.5 14318.4 14359.0 14362.4 14400.6 15703.1 15705.1 15903.6 15963.6 16090.6 12033.9 12171.5 12211.5 12265.1 12724.8 3898.3 3941.3 3967.2 4041.7 4050.1 75261.6 75484.6 75514.0 75576.0 75702.2 11871.0 11941.1 11976.2 12003.9 12143.8 23345.2 23364.0 23377.6 23436.6 23492.9 7921.8 8132.0 8211.9 8286.9 8298.4 4565.5 4861.4 4925.4 4949.9 4973.8 3434.4 3544.0 3547.1 3549.4 3557.3 597.7 597.8 610.4 612.3 613.8 659.6 673.0 699.3 701.8 706.5 9175.0 9722.2 9972.2 10035.0 10089.5 780.6 793.5 795.8 804.6 830.8 4400.2 4538.8 4543.0 4550.5 4604.7 113582.4 115744.4 115891.4 115920.4 116802.0 100329.0 100730.5 100947.5 101158.5 101924.5 56702.0 88130.1 90402.0 91946.0 93702.0 8769.6 8876.8 8933.4 9067.0 9188.1 50378.5 50450.5 50978.0 52300.7 52337.7 71655.3 76339.0 76467.6 77422.6 79749.0 11776.9 12126.3 12177.2 12362.3 12553.3 13116.9 14022.5 14048.2 14220.3 14511.6 12397.4 12499.0 12682.0 12795.1 12981.2 12710.2 12780.6 12882.5 12904.9 13321.5 12779.9 13385.9 13422.1 13542.2 13855.9 10418.8 10867.9 10921.3 10922.8 11436.7 10110.5 10154.7 10798.9 10900.4 10980.1 17:15:29 INFO - PROCESS | 3553 | -------- Summary: end -------- 17:15:29 INFO - PROCESS | 3553 | 17:15:30 INFO - TEST-INFO | 3553: exit 0 17:15:30 INFO - TEST-OK | dromaeo_css | took 1112317ms 17:15:30 INFO - TEST-START | kraken 17:15:30 INFO - operating with platform_type : linux_ 17:15:30 INFO - Initialising browser for kraken test... 17:15:30 INFO - TEST-INFO | started process 3797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEnZTd/profile http://localhost:60243/getInfo.html) 17:15:35 INFO - PROCESS | 3797 | __metrics Screen width/height:1600/1200 17:15:35 INFO - PROCESS | 3797 | colorDepth:24 17:15:35 INFO - PROCESS | 3797 | Browser inner width/height: 1024/697 17:15:35 INFO - PROCESS | 3797 | __metrics 17:15:36 ERROR - PROCESS | 3797 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:15:37 INFO - TEST-INFO | 3797: exit 0 17:15:37 INFO - Browser initialized. 17:15:37 INFO - Running cycle 1/1 for kraken test... 17:15:37 INFO - TEST-INFO | started process 3921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEnZTd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:49 INFO - PROCESS | 3921 | RSS: Main: 168456192 17:15:49 INFO - PROCESS | 3921 | 17:15:51 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60243/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:52 INFO - PROCESS | 3921 | RSS: Main: 173924352 17:15:52 INFO - PROCESS | 3921 | 17:15:55 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60243/tests/kraken/driver.html?testName=audio-dft) 17:15:55 INFO - PROCESS | 3921 | RSS: Main: 173395968 17:15:55 INFO - PROCESS | 3921 | 17:15:58 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60243/tests/kraken/driver.html?testName=audio-fft) 17:15:59 INFO - PROCESS | 3921 | RSS: Main: 168013824 17:15:59 INFO - PROCESS | 3921 | 17:16:01 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60243/tests/kraken/driver.html?testName=audio-oscillator) 17:16:01 INFO - PROCESS | 3921 | RSS: Main: 168890368 17:16:01 INFO - PROCESS | 3921 | 17:16:04 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:16:04 INFO - PROCESS | 3921 | RSS: Main: 169512960 17:16:04 INFO - PROCESS | 3921 | 17:16:07 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60243/tests/kraken/driver.html?testName=imaging-darkroom) 17:16:08 INFO - PROCESS | 3921 | RSS: Main: 169435136 17:16:08 INFO - PROCESS | 3921 | 17:16:11 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60243/tests/kraken/driver.html?testName=imaging-desaturate) 17:16:12 INFO - PROCESS | 3921 | RSS: Main: 167714816 17:16:12 INFO - PROCESS | 3921 | 17:16:15 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60243/tests/kraken/driver.html?testName=json-parse-financial) 17:16:15 INFO - PROCESS | 3921 | RSS: Main: 168361984 17:16:15 INFO - PROCESS | 3921 | 17:16:17 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:16:18 INFO - PROCESS | 3921 | RSS: Main: 168574976 17:16:18 INFO - PROCESS | 3921 | 17:16:19 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:20 INFO - PROCESS | 3921 | RSS: Main: 169078784 17:16:20 INFO - PROCESS | 3921 | 17:16:22 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:23 INFO - PROCESS | 3921 | RSS: Main: 169861120 17:16:23 INFO - PROCESS | 3921 | 17:16:25 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:26 INFO - PROCESS | 3921 | RSS: Main: 169848832 17:16:26 INFO - PROCESS | 3921 | 17:16:29 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:29 INFO - PROCESS | 3921 | RSS: Main: 169631744 17:16:29 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | Cycle 1(1): loaded http://localhost:60243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60243/tests/kraken/driver.html?testName=ai-astar) 17:16:31 INFO - PROCESS | 3921 | RSS: Main: 170278912 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | __start_tp_report 17:16:31 INFO - PROCESS | 3921 | _x_x_mozilla_page_load 17:16:31 INFO - PROCESS | 3921 | _x_x_mozilla_page_load_details 17:16:31 INFO - PROCESS | 3921 | |i|pagename|runs| 17:16:31 INFO - PROCESS | 3921 | |0;ai-astar;104;111;105;111;111;113;112;113;113;111 17:16:31 INFO - PROCESS | 3921 | |1;audio-beat-detection;149;117;143;174;121;142;161;123;176;121 17:16:31 INFO - PROCESS | 3921 | |2;audio-dft;163;163;165;162;162;163;174;161;162;162 17:16:31 INFO - PROCESS | 3921 | |3;audio-fft;74;75;74;163;75;75;76;75;164;75 17:16:31 INFO - PROCESS | 3921 | |4;audio-oscillator;85;85;145;85;85;86;143;85;85;146 17:16:31 INFO - PROCESS | 3921 | |5;imaging-gaussian-blur;117;117;118;118;117;117;118;117;117;118 17:16:31 INFO - PROCESS | 3921 | |6;imaging-darkroom;147;148;149;147;149;147;148;147;148;147 17:16:31 INFO - PROCESS | 3921 | |7;imaging-desaturate;96;96;96;99;95;95;95;96;96;96 17:16:31 INFO - PROCESS | 3921 | |8;json-parse-financial;54;55;55;53;57;54;55;55;54;55 17:16:31 INFO - PROCESS | 3921 | |9;json-stringify-tinderbox;61;61;61;61;61;62;61;61;65;62 17:16:31 INFO - PROCESS | 3921 | |10;stanford-crypto-aes;78;80;74;74;77;76;76;76;76;75 17:16:31 INFO - PROCESS | 3921 | |11;stanford-crypto-ccm;135;126;130;125;130;118;122;132;165;118 17:16:31 INFO - PROCESS | 3921 | |12;stanford-crypto-pbkdf2;161;158;157;160;159;158;162;159;159;161 17:16:31 INFO - PROCESS | 3921 | |13;stanford-crypto-sha256-iterative;65;62;65;69;63;64;66;70;64;64 17:16:31 INFO - PROCESS | 3921 | __end_tp_report 17:16:31 INFO - PROCESS | 3921 | __start_cc_report 17:16:31 INFO - PROCESS | 3921 | _x_x_mozilla_cycle_collect,916 17:16:31 INFO - PROCESS | 3921 | __end_cc_report 17:16:31 INFO - PROCESS | 3921 | __startTimestamp1467245791720__endTimestamp 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | ------- Summary: start ------- 17:16:31 INFO - PROCESS | 3921 | Number of tests: 14 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.24 (2.9%) stddev-sans-first:2.47 17:16:31 INFO - PROCESS | 3921 | Values: 104.0 111.0 105.0 111.0 111.0 113.0 112.0 113.0 113.0 111.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:146.00 stddev:22.25 (15.2%) stddev-sans-first:23.48 17:16:31 INFO - PROCESS | 3921 | Values: 149.0 117.0 143.0 174.0 121.0 142.0 161.0 123.0 176.0 121.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.77 (2.3%) stddev-sans-first:3.99 17:16:31 INFO - PROCESS | 3921 | Values: 163.0 163.0 165.0 162.0 162.0 163.0 174.0 161.0 162.0 162.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.00 stddev:37.37 (49.8%) stddev-sans-first:39.03 17:16:31 INFO - PROCESS | 3921 | Values: 74.0 75.0 74.0 163.0 75.0 75.0 76.0 75.0 164.0 75.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:28.76 (33.8%) stddev-sans-first:29.76 17:16:31 INFO - PROCESS | 3921 | Values: 85.0 85.0 145.0 85.0 85.0 86.0 143.0 85.0 85.0 146.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:16:31 INFO - PROCESS | 3921 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 17:16:31 INFO - PROCESS | 3921 | Values: 147.0 148.0 149.0 147.0 149.0 147.0 148.0 147.0 148.0 147.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.15 (1.2%) stddev-sans-first:1.22 17:16:31 INFO - PROCESS | 3921 | Values: 96.0 96.0 96.0 99.0 95.0 95.0 95.0 96.0 96.0 96.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.09 17:16:31 INFO - PROCESS | 3921 | Values: 54.0 55.0 55.0 53.0 57.0 54.0 55.0 55.0 54.0 55.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.32 17:16:31 INFO - PROCESS | 3921 | Values: 61.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 65.0 62.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:1.81 (2.4%) stddev-sans-first:1.80 17:16:31 INFO - PROCESS | 3921 | Values: 78.0 80.0 74.0 74.0 77.0 76.0 76.0 76.0 76.0 75.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:130.00 stddev:13.53 (10.4%) stddev-sans-first:14.23 17:16:31 INFO - PROCESS | 3921 | Values: 135.0 126.0 130.0 125.0 130.0 118.0 122.0 132.0 165.0 118.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:159.50 stddev:1.58 (1.0%) stddev-sans-first:1.56 17:16:31 INFO - PROCESS | 3921 | Values: 161.0 158.0 157.0 160.0 159.0 158.0 162.0 159.0 159.0 161.0 17:16:31 INFO - PROCESS | 3921 | 17:16:31 INFO - PROCESS | 3921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:2.53 (3.9%) stddev-sans-first:2.68 17:16:31 INFO - PROCESS | 3921 | Values: 65.0 62.0 65.0 69.0 63.0 64.0 66.0 70.0 64.0 64.0 17:16:31 INFO - PROCESS | 3921 | -------- Summary: end -------- 17:16:31 INFO - PROCESS | 3921 | 17:16:32 INFO - TEST-INFO | 3921: exit 0 17:16:32 INFO - TEST-OK | kraken | took 62466ms 17:16:32 INFO - SUITE-END | took 1174s 17:16:32 INFO - Completed test suite (00:19:34) 17:16:32 INFO - javascript benchmark 17:16:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7417.131481039541, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.39737251236, 3141.8114913105214, 3166.6358368787583, 3196.1530194498478, 3201.9359612807743, 5355.839324820252, 5356.866078348044, 5384.946150538493, 5480.424555421683, 5538.778448862041, 5367.2485851980755, 5470.452954704528, 5531.861703457415, 5594.9720251398685, 5617.466340697637, 4917.016596680669, 4927.408710954691, 4942.752862356886, 5071.340725705653, 5127.205283181094, 4931.630127740415, 5082.466341034194, 5118.232265160219, 5132.0, 5133.512316329943, 4888.877778055541, 4936.753162341868, 4958.578520825734, 4992.925106123411, 5001.8499445016705, 4964.1809101498575, 4978.726170060645, 4981.526754958273, 4983.90032199354, 5019.974900125476, 4920.901581968376, 4945.67853089548, 4951.529604687549, 4959.132151873444, 4985.950140498621, 5289.629725919187, 5352.090144675376, 5418.431064738185, 5463.098588732854, 5509.0, 5902.704864756745, 5902.937471255173, 5906.497947674453, 5917.585768996172, 5918.40815918409, 5756.424357564252, 5959.940400596025, 5960.701964901781, 5960.97019514904, 5971.761129554812, 5434.565234781208, 5456.536194423479, 5503.3120859892515, 5531.2809334787025, 5534.1975413564805, 5998.130271110752, 6004.489618382487, 6031.035034394476, 6037.758489660365, 6040.244969378828, 5605.990921634064, 5724.513416359656, 5736.397678243808, 5748.0, 5753.194552762617, 5839.386864379264, 5922.052471604523, 5922.615030023035, 5925.140854576149, 5987.371326010706, 5641.887162256732, 5773.769049238067, 5827.59206855516, 5906.911396329058, 5912.408759124053, 5685.260916080883, 5764.193012978187, 5820.0, 5859.472647461749, 5871.794487193013, 4475.9552404475535, 4499.977500112478, 4504.2793153095345, 4544.977275113603, 4561.863144105682, 3946.5856085111222, 3951.3677811550015, 3967.107400834847, 3970.8610198643487, 3974.5627980922077, 5498.367687715884, 5502.257195278587, 5556.333240011144, 5571.303587051619, 5602.439756024365, 5838.2702162229725, 5912.142739302777, 5915.201447804578, 5919.052951527735, 5969.970150149222, 5549.472800083986, 5564.360098588633, 5593.0, 5600.215969764155, 5602.38373778884, 5002.774875130555, 5043.924341134886, 5079.8984020319385, 5092.108880945893, 5095.541401273903, 6120.447133218794, 6123.252510653108, 6125.082842094287, 6136.507825496156, 6141.977005061692, 5910.320313163869, 5912.526997840248, 5912.645241285537, 5913.526917846476, 5969.194158788508, 5877.324107727666, 6058.787942421994, 6073.271207455134, 6112.663803490851, 6123.8469038272615, 5773.538116950718, 5790.363060063305, 5807.925533776096, 5810.389909059657, 5818.214541036906, 5860.8571328590515, 5905.261842269716, 5916.112583112567, 5916.171735956884, 5921.3190483094995, 5527.474889885454, 5612.7754889803955, 5654.830355089354, 5688.374278829243, 5705.828825135252, 5676.971615141898, 5690.544756419559, 5692.231548740867, 5698.857528561653, 5744.339400968942, 5606.85982850432, 5613.691246981455, 5621.184928185308, 5634.464725851038, 5669.177969194361, 5621.606487545832, 5621.662700237999, 5638.830835074954, 5727.513161381163, 5806.216160818235, 5593.384727680033, 5619.325680918316, 5622.493975542221, 5624.465675760796, 5651.745671444713], "value": 5403.804122638347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.9772409103637, 604.9364816694247, 606.8058221369163, 631.1258906414618, 680.9659517024147, 37876.0, 42793.93015174626, 42795.144097118115, 42811.78594107033, 42825.0, 40281.19437611246, 40923.386149207785, 41015.0, 41034.79482602583, 41052.17895642085, 8734.606942687578, 8888.06675299094, 8899.733008009738, 8903.777405564848, 8942.41874278173, 8858.689945851896, 8911.242544383702, 8918.598663060178, 8918.73243802687, 8938.329625278098, 9001.369904106716, 9009.684661036865, 9020.54897255138, 9027.368084234105, 9030.0, 8973.730788076367, 8977.685780997634, 9002.549872506414, 9007.324450666227, 9011.143941325563, 8685.782855428602, 8815.867761983576, 8853.424527405698, 8882.067382924764, 8893.4663920165, 33862.661373386196, 40725.0, 41122.38316425256, 41136.58863411358, 41167.176656467, 3248.13924310058, 3260.673932606744, 3493.2140268439653, 3648.4344926536164, 4035.3139966205817, 30114.397712045855, 30515.847420762977, 30533.236669083228, 30673.539896901566, 30937.0, 4206.0, 4269.807858646368, 4288.120935208275, 4357.760323182224, 4431.091626216617, 308772.0, 310027.0, 310274.0, 310275.0, 311526.0, 35749.0, 36396.636033639326, 36415.453768193496, 36447.0, 36448.08879778027, 37094.44358334627, 39417.0, 40150.397744033864, 40208.19583608311, 40334.1933161341, 16525.25636346367, 16592.668146637, 16673.49979500617, 16685.0, 16821.91589042047, 13730.313484325743, 13751.862481375258, 13759.38082786277, 13761.036727429184, 13852.238126902916, 19402.8059719401, 19578.021098944995, 19611.234988851073, 19615.0, 19687.0, 7128.501004929709, 7285.526440781332, 7421.765716797916, 7484.625768711543, 7559.470837041355, 955.6702937486556, 1082.7130810335268, 1088.7006073329899, 1097.3032124600936, 1109.3454861631515, 32527.512087318708, 32636.18409539733, 32692.182695432806, 32857.67142328594, 32887.61572467932, 1138.0952143046297, 1173.4250217393417, 1182.6097387862158, 1196.5692350753723, 1259.5906330442642, 17226.655466890592, 17398.56503587395, 17960.910195448938, 18016.819831801775, 18644.16101275446, 566319.0, 797996.0, 798838.0, 800689.0, 804170.0, 59077.40922590719, 59431.10853337203, 59820.0, 59916.0, 60083.399166008654, 1387.6045327081733, 1421.2183299185613, 1426.187073368191, 1426.493594773861, 1434.9497767578293, 30908.536371954888, 32796.67203327936, 33122.66877331292, 33140.33719325552, 33341.0, 49453.50546494489, 50002.0, 50381.49618503915, 50419.49580504148, 50425.747871260406, 500980.0, 507525.0, 511586.0, 512559.0, 513762.0, 29141.125766227047, 29188.708112918597, 29194.270143246587, 29484.85257573784, 29500.704992950654, 46574.76712616415, 47383.28925066058, 47385.0, 48302.51697483121, 48530.27204591863, 40080.0, 40225.798871005456, 40432.79783601063, 40615.79692101521, 40826.0, 40560.1887962245, 40575.1884962305, 40584.0, 40695.79652101839, 41382.172356552095, 34309.82845085759, 38898.80550597229, 39704.0, 39829.80085099556, 40309.0, 35388.292234155684, 36761.448578270814, 36830.0, 37378.8131059343, 37463.81268093642, 27590.0, 28220.717792821808, 28400.0, 28550.85724571364, 28703.282417939718], "value": 19919.557225447377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.835231731149, 410.64299352790965, 415.12823071549747, 420.16177725437745, 424.35074336265524, 18784.248630054797, 19992.5001874953, 20217.494562635922, 20522.589548209027, 21261.14955401786, 19328.130234139462, 19559.511012224702, 19857.70213446796, 19969.800301997013, 20110.195592176296, 5769.653820770746, 5865.061590145578, 5967.940320596782, 6006.978813601676, 6093.268807743077, 5860.794872179475, 5884.764609415618, 5902.409759024106, 5932.466078052975, 5968.343482216975, 5764.769409223626, 5863.58954873159, 5867.794627188049, 5926.0, 5976.462118409342, 5804.825855224329, 5901.586888917777, 5902.468777809996, 5958.344582095966, 5972.9701351493395, 5239.266502689627, 5287.841364759063, 5303.5226829585135, 5352.973235133838, 5357.946420535784, 19330.710039349422, 19834.504137396536, 23720.0, 23865.0, 24199.879000605062, 2405.446747248125, 2496.6379874918034, 2626.3171575390347, 2635.894564217429, 2669.706332303445, 14783.852161478462, 15118.848811511854, 15403.691926161415, 15474.148921809296, 15564.14397208153, 1986.6721990871488, 2055.825254853339, 2081.9375418737463, 2082.562661841, 2115.947101322464, 84818.57590712068, 85475.57262213712, 85926.14073859244, 86654.0, 87088.12911870927, 11239.157063220291, 11280.097592192606, 11371.658850234506, 11430.0, 11815.11386646005, 15832.60418489547, 15873.0, 15997.440089596808, 16008.759868601981, 16036.198190090683, 8255.091939886608, 8321.833563328699, 8500.532470714046, 8625.525596092275, 8651.480911145225, 8240.258376746122, 8344.457610255315, 8366.121557236402, 8425.272819072075, 8707.172818582225, 6690.632015239111, 6746.392824645805, 6819.965900170468, 6909.516333856582, 6919.0, 1988.8862237147243, 2024.7266619006245, 2038.9694154587396, 2051.3845846246068, 2057.8270385880205, 986.6990567876867, 992.6277645882794, 1006.0593345222094, 1014.3710899242517, 1055.7096798380353, 20441.182352705724, 21129.7280025563, 21180.682289765668, 21208.681869771965, 21452.24917127893, 1040.3237895368072, 1047.4814966591587, 1063.6011495689118, 1133.2067552713133, 1139.1058019454688, 11322.60370887015, 11818.40907954616, 11997.340146292037, 12035.699107522381, 12094.516219351128, 366966.0, 368036.0, 368529.0, 507073.0, 513164.0, 62957.37042629607, 102697.45953810698, 103398.0, 103893.0, 106841.46579267054, 1014.7868947521104, 1047.272145858621, 1056.772793849326, 1073.742301847551, 1087.1846115413439, 18741.437756867315, 18915.243390264237, 19584.8041519583, 19662.311819086837, 19710.043493476092, 44045.483536633874, 44788.55211447974, 45153.0, 46427.76786116048, 46956.06087878155, 64267.67866160639, 66278.33721662722, 66833.66583167053, 67335.0, 67885.66057169682, 8757.737267881974, 8863.689770857989, 8901.065388134153, 8987.550622468982, 9120.361574689709, 13903.026788124735, 14273.006912385443, 14309.069910455786, 14399.712005760035, 14553.19957402353, 12634.557790477656, 12670.619881403572, 12721.491140354283, 12768.042396820461, 12902.806457903327, 12085.15403921717, 12523.37383130858, 12548.24710517372, 12760.979121670058, 12802.039847011325, 12642.683932901751, 12729.172603781095, 12807.487700491876, 12859.678508037, 12925.935370323088, 8719.34604904622, 8774.780630484289, 8883.756274121757, 8964.238039766693, 9243.537823108953, 8796.208341249063, 11769.764604708029, 12560.811587826007, 12714.11001229905, 12890.29103399322], "value": 9842.0995887094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.755424023676, 1423.9644008899777, 1501.2943916359307, 1787.955301117472, 1796.1827368547313, 7848.372130229583, 8640.179182977623, 8802.383833131684, 9136.314776391764, 9139.405938613994, 8837.293016558677, 8865.335099867503, 8941.86587201191, 8948.194662480391, 8963.596638151283, 2375.58427275227, 2412.7345991940874, 2417.8428402153804, 2421.878906054699, 2423.7939775119135, 2347.4366152123453, 2387.462820865309, 2434.440078781872, 2434.671319371889, 2443.9389015274583, 2346.8826558672085, 2380.6310021946624, 2395.9760402396014, 2398.0887262840097, 2410.1564452441594, 2327.615943369342, 2341.484873327865, 2357.5167090746354, 2358.84667496613, 2371.822113341489, 2328.1734984080745, 2341.812654987597, 2342.5900467418132, 2345.6129738593113, 2356.611159158737, 9036.638534458614, 9084.909150908472, 9087.454752714859, 9148.725538233864, 9169.312301577342, 5292.576593872481, 5390.0836857734275, 5395.3525576931015, 5419.34967803866, 5420.24116623673, 3504.5794504659602, 3518.2963407318384, 3529.347070791886, 3581.247937933037, 3658.0854786303425, 1159.0437888741737, 1173.290159453527, 1199.7000749812546, 1205.9397030148457, 1212.6059030814931, 12625.24248545081, 12636.873631263661, 12680.239185648798, 12688.492460301577, 12704.0, 4496.752678602643, 4666.440027196758, 4737.265723812815, 4762.571368576845, 4791.904161916812, 10526.473676316153, 10528.0, 10538.051575358255, 10554.208434367452, 10575.788484230272, 5224.582033437316, 5242.842714718565, 5257.868553286198, 5289.206619007103, 5310.628256022119, 4431.623312018514, 4877.6585639004925, 4878.43897951733, 5029.2958985742025, 5035.370578677665, 4103.774292413946, 4129.772862492532, 4172.4784401949755, 4192.431301228207, 4193.958060419418, 1289.8839104480642, 1290.3096843188848, 1295.371744703818, 1298.6623477895814, 1308.3065975033248, 857.8970523537215, 971.2327261463506, 973.3332667123043, 977.4770497783652, 979.86771785808, 5935.228420305419, 5954.940450595439, 5959.046552551657, 5975.67133807636, 6042.244719410074, 413.0, 416.2465936654665, 420.6550628484674, 420.86532309661226, 440.6893140336055, 3927.430522574268, 3978.264021156095, 4036.414719865603, 4050.10897602527, 4060.715749897479, 11070.778584428266, 11204.271722338022, 11256.0, 11262.887371126348, 11342.262752921033, 10474.68575942723, 10975.780484390267, 11215.551377944954, 11273.661790146145, 11275.097992160772, 8417.368697347601, 8518.105598912025, 8557.229849313717, 8628.52543110135, 8632.525211113449, 5959.404059594006, 6096.542759292982, 6225.750969961332, 6236.376362363909, 6327.778527751507, 9914.652987145415, 10127.848082278919, 10359.689209323733, 10443.94778026105, 10569.365838049742, 10440.947795260976, 10474.842877356694, 10619.575216991234, 10743.46282685847, 10752.569897204337, 7427.331540161412, 7909.129995700353, 8050.5169689818795, 8110.553919534483, 8218.547979861165, 8950.23922966555, 8960.238379737535, 8994.0, 9051.818963620559, 9061.456312621263, 7714.5756983366455, 7944.768352146434, 8099.716509922125, 8123.268905798506, 8240.340772738047, 7949.602519873867, 8025.678972841254, 8058.315043221158, 8084.110747817617, 8126.959365203136, 6838.897416538656, 7068.858622827617, 7193.892091618525, 7252.093488313961, 7282.089738782653, 4979.452260251297, 5026.472220416804, 5165.560927321219, 5193.76628051731, 5254.894902102013, 4984.900301993867, 5113.53978141969, 5192.27308176848, 5245.868853278546, 5342.252084708066], "value": 4642.377558685715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.6737029285568, 326.1991810106189, 329.3692578711768, 329.8499182871795, 330.7337593237446, 5631.549476041917, 5721.31344238692, 5728.25532680752, 5733.136730562568, 5744.913826292609, 5539.529140023093, 5601.80393686221, 5606.831795046155, 5621.8032368867, 5650.9152362714485, 4140.515690585639, 4181.393697913801, 4329.67527435442, 4346.717973064151, 4349.913001739963, 4311.1808756336195, 4339.761313127777, 4343.087951530167, 4355.390245365651, 4364.25807612705, 4328.177646247219, 4341.500727416356, 4362.6727995400315, 4364.825406983733, 4366.820958341246, 4227.328801674152, 4253.361995700654, 4318.956810431919, 4319.870403887889, 4329.805158767832, 3772.622737726233, 3773.2830762155377, 3774.698024158088, 3777.660010599059, 3786.583475817658, 5424.945750542483, 5459.0, 5465.371482279549, 5473.31583552056, 5476.424975377608, 4856.344393506866, 4929.260610908356, 4944.629152813517, 4946.3817022872145, 4947.381577302837, 5838.562107841886, 5871.442212989802, 5883.23517942669, 5885.705714714247, 5899.764009439617, 4190.057237121654, 4195.244855925932, 4208.831646734127, 4224.134052519226, 4224.894377640553, 5893.675847828367, 6141.662208578527, 6170.7531698732, 6188.938110618881, 6208.782692605782, 4231.174920890458, 4241.681873859473, 4259.680523960716, 4267.146570685875, 4287.485501739811, 4291.120320334324, 4314.158739045856, 4319.67602429819, 4324.113556720865, 4333.544977777288, 4842.612590992712, 4931.5315045070665, 4932.150443583656, 4997.800527873284, 5004.924926126111, 5887.4398284454655, 5890.558208134407, 5898.0, 5899.793507227227, 5925.170476133345, 1494.4619936822735, 1507.3895072495657, 1515.4392874636235, 1519.9088054716754, 1523.2231561903288, 931.6785708930408, 959.3284700709531, 990.4700984973005, 993.6919554937992, 1001.4792307999945, 5735.885282294331, 5747.339056008529, 5758.7696492140685, 5798.9130163047585, 5828.591998560145, 6068.271807383054, 6100.084987251859, 6102.72537735803, 6115.388461153938, 6127.571070025145, 5524.5139687140945, 5667.263255776723, 5741.96644603967, 5750.741216645261, 5761.5102716269585, 3212.554350542265, 3218.2115381731624, 3223.8065716056644, 3243.918902027421, 3246.886358977472, 6037.879242415127, 6190.1952746142715, 6193.504519638508, 6246.406591373812, 6385.808425747142, 6206.627602343783, 6212.81361559154, 6223.657698826518, 6229.691764729367, 6276.46650034743, 6135.96932015346, 6234.812955611339, 6252.906206406908, 6270.529710271748, 6282.246130464282, 6152.5082341651705, 6154.815355539341, 6170.197874276495, 6217.626942383471, 6246.46905013079, 6092.756289748538, 6115.174451448997, 6160.0, 6174.25908890936, 6179.598326108969, 6272.717727702173, 6389.201349831271, 6407.8718425630295, 6415.9358406417205, 6437.969924812008, 4265.808038638207, 4296.6347860432215, 4303.096349766584, 4306.784660767012, 4317.0934103838545, 5933.495652869555, 6035.336113027652, 6159.384061593805, 6209.906851397142, 6224.626522408489, 5922.460160358251, 5925.0, 5949.0, 5954.46409823118, 5968.403159683997, 5723.969685456491, 5856.209411729533, 5904.498117660047, 5930.0, 5960.5231581474245, 5785.739641716217, 5803.390643982321, 5833.008388573868, 5837.824865254049, 5842.824715258549, 5947.613405128653, 5949.553783466344, 5975.910361344497, 5976.462118409364, 5996.67018313997, 5548.611597188158, 5766.4233576642, 5849.444302791228, 5849.883002339844, 5858.7070646468355], "value": 4492.7188706141615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.645369902995, 784.6743601405417, 829.5520418973753, 847.0555330806153, 852.5609311204729, 13810.309484525771, 14596.562103136896, 14872.405103795862, 14875.404983800649, 14993.17537535435, 13843.653908652288, 14078.366473508717, 14090.225037622953, 14100.506482273122, 14121.85878141221, 673.6328700858044, 787.3425689549233, 814.4543156085437, 818.0592318833329, 819.315871247509, 784.6782819044194, 810.1857633078747, 811.0146172400532, 812.1796985045117, 814.7963009247688, 868.0885070675797, 871.2333146830812, 874.4316194473611, 875.4309698695866, 878.056089703568, 865.0830120072743, 866.4151697604156, 867.4405008769371, 872.2367928062945, 872.62477134832, 630.9495240380759, 633.5153607490273, 633.6103296472636, 635.5836926812945, 638.2245571630491, 14299.499517516837, 14318.427262909576, 14359.0, 14362.420133785276, 14400.63998400038, 15703.136327501983, 15705.136217508032, 15903.60240993973, 15963.600909977227, 16090.5977350566, 12033.939830300793, 12171.513139474411, 12211.511539538496, 12265.080118991022, 12724.809127863089, 3898.2593307271527, 3941.2511622791576, 3967.226390853785, 4041.6564592009713, 4050.0887300357476, 75261.62369188119, 75484.62257688731, 75514.0, 75576.0, 75702.24297757063, 11871.0, 11941.147415844773, 11976.221545599683, 12003.939980300218, 12143.817842732366, 23345.182918597766, 23364.0, 23377.649335259986, 23436.64845027326, 23492.882535587214, 7921.801954951173, 8132.0, 8211.876821847676, 8286.917130828615, 8298.377621678399, 4565.474970378383, 4861.440934292602, 4925.433575138905, 4949.90100197994, 4973.801047958041, 3434.364642541138, 3544.025393016889, 3547.095490649919, 3549.378858699769, 3557.3063252665997, 597.6593341795135, 597.8271663786707, 610.4018062298971, 612.2866860107924, 613.8342647485154, 659.6273105695267, 672.9596224226563, 699.3076853914689, 701.7719241246615, 706.477206866925, 9174.954125229464, 9722.222222222204, 9972.202223822076, 10035.0, 10089.495525223856, 780.594091072639, 793.4525177627419, 795.7572940253278, 804.6379129391797, 830.8451252758671, 4400.22995975703, 4538.750368729686, 4542.977285113553, 4550.522195169526, 4604.700694454849, 113582.43208783903, 115744.42127789475, 115891.42054289674, 115920.42039789916, 116802.0, 100329.0, 100730.49634751926, 100947.49526252321, 101158.49420752849, 101924.49037754913, 56702.0, 88130.11869881219, 90402.0, 91946.0, 93701.99999999863, 8769.605367758339, 8876.822463550821, 8933.419327743675, 9067.0, 9188.081191880758, 50378.49621503738, 50450.495495046045, 50978.0, 52300.73849630728, 52337.738311309724, 71655.28344716487, 76339.0, 76467.61766191134, 77422.61288693521, 79749.0, 11776.941115294369, 12126.333051682243, 12177.208481448677, 12362.258264503798, 12553.309567973849, 13116.934415327862, 14022.509212177933, 14048.157110573398, 14220.288985550475, 14511.564653060424, 12397.380130993595, 12499.0, 12682.048846336376, 12795.104342696295, 12981.221126732426, 12710.237385756884, 12780.61658150257, 12882.549110781078, 12904.870951290366, 13321.467141314239, 12779.898439865536, 13385.933070334586, 13422.127561708849, 13542.187468751512, 13855.850209175753, 10418.843717344398, 10867.886938114805, 10921.344719316867, 10922.836157457803, 11436.701550176222, 10110.545025474019, 10154.672834306248, 10798.892011079788, 10900.370612600678, 10980.1215902726], "value": 7534.532400736883, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 105.0, 111.0, 111.0, 113.0, 112.0, 113.0, 113.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 143.0, 174.0, 121.0, 142.0, 161.0, 123.0, 176.0, 121.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 162.0, 162.0, 163.0, 174.0, 161.0, 162.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 163.0, 75.0, 75.0, 76.0, 75.0, 164.0, 75.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 145.0, 85.0, 85.0, 86.0, 143.0, 85.0, 85.0, 146.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 99.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 53.0, 57.0, 54.0, 55.0, 55.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 65.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 74.0, 74.0, 77.0, 76.0, 76.0, 76.0, 76.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 126.0, 130.0, 125.0, 130.0, 118.0, 122.0, 132.0, 165.0, 118.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 157.0, 160.0, 159.0, 158.0, 162.0, 159.0, 159.0, 161.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 65.0, 69.0, 63.0, 64.0, 66.0, 70.0, 64.0, 64.0], "value": 65.2, "unit": "score"}]}]} 17:16:32 INFO - Return code: 0 17:16:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:16:33 ERROR - # TBPL SUCCESS # 17:16:33 INFO - Running post-action listener: _resource_record_post_action 17:16:33 INFO - ##### 17:16:33 INFO - ##### Finished run-tests step (success) 17:16:33 INFO - ##### 17:16:33 INFO - Running post-run listener: _resource_record_post_run 17:16:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 535314432; Read time: 0; Write time: 1612512 17:16:33 INFO - TinderboxPrint: CPU usage
13.4% 17:16:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:16:33 INFO - TinderboxPrint: I/O write bytes / time
535,314,432 / 1,612,512 17:16:33 INFO - TinderboxPrint: CPU idle
8,234.4 (86.6%) 17:16:33 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 17:16:33 INFO - TinderboxPrint: Swap in / out
0 / 0 17:16:33 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 206692352; Read time: 0; Write time: 909868 17:16:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 292851712; Read time: 0; Write time: 609672 17:16:33 INFO - Running post-run listener: _upload_blobber_files 17:16:33 INFO - Blob upload gear active. 17:16:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:16:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:16:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:16:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:37 INFO - (blobuploader) - INFO - Done attempting. 17:16:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:38 INFO - (blobuploader) - INFO - Done attempting. 17:16:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:39 INFO - (blobuploader) - INFO - Done attempting. 17:16:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:39 INFO - Return code: 0 17:16:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7bda21ea99d4dfbe90aa7b1b2e6f057f8a4720a569dd3caaf185697c90f4018261ed5204cbe6c39f0b83a8314602211c614cc2386f8db952b038ad95bb9af5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e79cdf1263c4a5acf45467d9a7377c08901a429a9d826f33d0017c7172fb864cda30c348cdc4202a0fbd2a4efebd59fa5ae5c2ffa07f7fc41cc0e006ec13078", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/048cd5a902af48f94e5e509fdd951145193c428521a3fb7088b7d50400078103cc8a098c217e5001fe228017a7d57532e1574f9b8613e4352db2dc111ff5cfde"} 17:16:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:39 INFO - Contents: 17:16:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7bda21ea99d4dfbe90aa7b1b2e6f057f8a4720a569dd3caaf185697c90f4018261ed5204cbe6c39f0b83a8314602211c614cc2386f8db952b038ad95bb9af5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e79cdf1263c4a5acf45467d9a7377c08901a429a9d826f33d0017c7172fb864cda30c348cdc4202a0fbd2a4efebd59fa5ae5c2ffa07f7fc41cc0e006ec13078", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/048cd5a902af48f94e5e509fdd951145193c428521a3fb7088b7d50400078103cc8a098c217e5001fe228017a7d57532e1574f9b8613e4352db2dc111ff5cfde"} 17:16:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:39 INFO - Copying logs to upload dir... 17:16:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.774976 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-29 17:16:39.253368) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 17:16:39.256950) ========= 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=df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7bda21ea99d4dfbe90aa7b1b2e6f057f8a4720a569dd3caaf185697c90f4018261ed5204cbe6c39f0b83a8314602211c614cc2386f8db952b038ad95bb9af5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e79cdf1263c4a5acf45467d9a7377c08901a429a9d826f33d0017c7172fb864cda30c348cdc4202a0fbd2a4efebd59fa5ae5c2ffa07f7fc41cc0e006ec13078", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/048cd5a902af48f94e5e509fdd951145193c428521a3fb7088b7d50400078103cc8a098c217e5001fe228017a7d57532e1574f9b8613e4352db2dc111ff5cfde"} build_url:https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/ANzTA9o0QRetYPwyLL_ukg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a7bda21ea99d4dfbe90aa7b1b2e6f057f8a4720a569dd3caaf185697c90f4018261ed5204cbe6c39f0b83a8314602211c614cc2386f8db952b038ad95bb9af5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e79cdf1263c4a5acf45467d9a7377c08901a429a9d826f33d0017c7172fb864cda30c348cdc4202a0fbd2a4efebd59fa5ae5c2ffa07f7fc41cc0e006ec13078", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/048cd5a902af48f94e5e509fdd951145193c428521a3fb7088b7d50400078103cc8a098c217e5001fe228017a7d57532e1574f9b8613e4352db2dc111ff5cfde"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 17:16:39.282202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:16:39.282596) ========= 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=df17445c3590ff7897617a0e00000225-1467244206.506193-1932458870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 17:16:39.366460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 17:16:39.366796) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 17:16:39.367080) ========= ========= Total master_lag: 0.19 =========