builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1483823170.48 results: success (0) revision: f40258de5ee269f22833bdcc36dff621814349cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.480399) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.480840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.481175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.500192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.500496) ========= 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=af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-07 13:06:10-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2017-01-07 13:06:11 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114282 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.628773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.629130) ========= 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=af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017396 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.679404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:10.679774) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f40258de5ee269f22833bdcc36dff621814349cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev f40258de5ee269f22833bdcc36dff621814349cd --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=af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-07 13:06:11,146 truncating revision to first 12 chars 2017-01-07 13:06:11,146 Setting DEBUG logging. 2017-01-07 13:06:11,146 attempt 1/10 2017-01-07 13:06:11,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f40258de5ee2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 13:06:11,461 unpacking tar archive at: mozilla-central-f40258de5ee2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613321 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:11.306657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:11.309421) ========= script_repo_revision: f40258de5ee269f22833bdcc36dff621814349cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:11.309965) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:11.310272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 13:06:11.320319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-07 13:06:11.320645) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:06:11 INFO - MultiFileLogger online at 20170107 13:06:11 in /builds/slave/test 13:06:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:06:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:06:11 INFO - {'append_to_log': False, 13:06:11 INFO - 'base_work_dir': '/builds/slave/test', 13:06:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:06:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:06:11 INFO - 'branch': 'Firefox-Non-PGO', 13:06:11 INFO - 'buildbot_json_path': 'buildprops.json', 13:06:11 INFO - 'config_files': ('talos/linux_config.py',), 13:06:11 INFO - 'default_actions': ('clobber', 13:06:11 INFO - 'read-buildbot-config', 13:06:11 INFO - 'download-and-extract', 13:06:11 INFO - 'populate-webroot', 13:06:11 INFO - 'create-virtualenv', 13:06:11 INFO - 'install', 13:06:11 INFO - 'run-tests'), 13:06:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:06:11 INFO - 'download_minidump_stackwalk': True, 13:06:11 INFO - 'download_symbols': 'ondemand', 13:06:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:06:11 INFO - 'tooltool.py': '/tools/tooltool.py', 13:06:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:06:11 INFO - '/tools/misc-python/virtualenv.py')}, 13:06:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:06:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:06:11 INFO - 'installer_path': 'installer.exe', 13:06:11 INFO - 'log_level': 'info', 13:06:11 INFO - 'log_name': 'talos', 13:06:11 INFO - 'log_to_console': True, 13:06:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:06:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:06:11 INFO - 'opt_config_files': (), 13:06:11 INFO - 'pip_index': False, 13:06:11 INFO - 'sps_profile': False, 13:06:11 INFO - 'sps_profile_interval': 0, 13:06:11 INFO - 'suite': 'dromaeojs-e10s', 13:06:11 INFO - 'system_bits': '32', 13:06:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:06:11 INFO - 'title': 'talos-linux64-ix-020', 13:06:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:06:11 INFO - 'use_talos_json': True, 13:06:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:06:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:06:11 INFO - 'work_dir': 'build'} 13:06:11 INFO - [mozharness: 2017-01-07 21:06:11.892831Z] Running clobber step. 13:06:11 INFO - Running pre-action listener: _resource_record_pre_action 13:06:11 INFO - Running main action method: clobber 13:06:11 INFO - rmtree: /builds/slave/test/build 13:06:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:06:12 INFO - Running post-action listener: _resource_record_post_action 13:06:12 INFO - [mozharness: 2017-01-07 21:06:12.883611Z] Finished clobber step (success) 13:06:12 INFO - [mozharness: 2017-01-07 21:06:12.883711Z] Running read-buildbot-config step. 13:06:12 INFO - Running pre-action listener: _resource_record_pre_action 13:06:12 INFO - Running main action method: read_buildbot_config 13:06:12 INFO - Using buildbot properties: 13:06:12 INFO - { 13:06:12 INFO - "project": "", 13:06:12 INFO - "product": "firefox", 13:06:12 INFO - "who": "ryanvm@gmail.com", 13:06:12 INFO - "installer_path": "public/build/target.tar.bz2", 13:06:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:06:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:06:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:06:12 INFO - "stage_platform": "linux64", 13:06:12 INFO - "basedir": "/builds/slave/test", 13:06:12 INFO - "buildnumber": 631, 13:06:12 INFO - "platform": "ubuntu64_hw", 13:06:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:06:12 INFO - "slavebuilddir": "test", 13:06:12 INFO - "taskId": "AvEiiHPvQh-FwJu2lgVHJA", 13:06:12 INFO - "branch": "mozilla-central", 13:06:12 INFO - "script_repo_revision": "production", 13:06:12 INFO - "revision": "f40258de5ee269f22833bdcc36dff621814349cd", 13:06:12 INFO - "slavename": "talos-linux64-ix-020", 13:06:12 INFO - "repo_path": "mozilla-central" 13:06:12 INFO - } 13:06:12 INFO - Finding installer, test and symbols from parent task. 13:06:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvEiiHPvQh-FwJu2lgVHJA'}, attempt #1 13:06:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvEiiHPvQh-FwJu2lgVHJA'}, attempt #1 13:06:13 INFO - Task dependencies: GKnLaoKSQ2SAyCTQjylZHQ 13:06:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ'}, attempt #1 13:06:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2 13:06:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/test_packages.json 13:06:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.crashreporter-symbols.zip 13:06:14 INFO - Running post-action listener: _resource_record_post_action 13:06:14 INFO - [mozharness: 2017-01-07 21:06:14.256367Z] Finished read-buildbot-config step (success) 13:06:14 INFO - [mozharness: 2017-01-07 21:06:14.256584Z] Running download-and-extract step. 13:06:14 INFO - Running pre-action listener: _resource_record_pre_action 13:06:14 INFO - Running main action method: download_and_extract 13:06:14 INFO - mkdir: /builds/slave/test/build/tests 13:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:14 INFO - trying https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.test_packages.json 13:06:14 INFO - Downloading https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:06:14 INFO - Downloaded 896 bytes. 13:06:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:06:14 INFO - Using the following test package requirements: 13:06:14 INFO - {u'common': [u'target.common.tests.zip'], 13:06:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:06:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:06:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:06:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:06:14 INFO - u'mozbase': [u'target.common.tests.zip'], 13:06:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:06:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:06:14 INFO - u'web-platform': [u'target.common.tests.zip', 13:06:14 INFO - u'target.web-platform.tests.zip'], 13:06:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:06:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:06:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.common.tests.zip 13:06:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:06:14 INFO - Fetch https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.common.tests.zip into memory 13:06:15 INFO - Expected file size: 20251356 13:06:15 INFO - Obtained file size: 20251356 13:06:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:06:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.common.tests.zip 13:06:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:06:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.common.tests.zip into memory 13:06:20 INFO - Expected file size: 20251356 13:06:20 INFO - Obtained file size: 20251356 13:06:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.talos.tests.zip 13:06:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:06:25 INFO - Fetch https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.talos.tests.zip into memory 13:06:25 INFO - Expected file size: 14403537 13:06:25 INFO - Obtained file size: 14403537 13:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:26 INFO - trying https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2 13:06:26 INFO - Downloading https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:06:28 INFO - Downloaded 55915749 bytes. 13:06:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2 13:06:28 INFO - mkdir: /builds/slave/test/properties 13:06:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:06:28 INFO - Writing to file /builds/slave/test/properties/build_url 13:06:28 INFO - Contents: 13:06:28 INFO - build_url:https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2 13:06:28 INFO - Running post-action listener: _resource_record_post_action 13:06:28 INFO - Running post-action listener: set_extra_try_arguments 13:06:28 INFO - [mozharness: 2017-01-07 21:06:28.107374Z] Finished download-and-extract step (success) 13:06:28 INFO - [mozharness: 2017-01-07 21:06:28.107524Z] Running populate-webroot step. 13:06:28 INFO - Running pre-action listener: _resource_record_pre_action 13:06:28 INFO - Running main action method: populate_webroot 13:06:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:06:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:06:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:06:28 INFO - '--tppagecycles', 13:06:28 INFO - '7'], 13:06:28 INFO - 'tests': ['tsvgm']}}, 13:06:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:06:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:06:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:06:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:06:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:06:28 INFO - 'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:06:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:06:28 INFO - 'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['damp', 'tps']}, 13:06:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:06:28 INFO - 'tests': ['damp', 'tps']}, 13:06:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['dromaeo_dom']}, 13:06:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:06:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['basic_compositor_video']}, 13:06:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:06:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['a11yr', 13:06:28 INFO - 'ts_paint', 13:06:28 INFO - 'tpaint', 13:06:28 INFO - 'sessionrestore', 13:06:28 INFO - 'sessionrestore_no_auto_restore', 13:06:28 INFO - 'tabpaint']}, 13:06:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:06:28 INFO - 'ts_paint', 13:06:28 INFO - 'tpaint', 13:06:28 INFO - 'sessionrestore', 13:06:28 INFO - 'sessionrestore_no_auto_restore', 13:06:28 INFO - 'tabpaint']}, 13:06:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:06:28 INFO - 'ts_paint', 13:06:28 INFO - 'tpaint', 13:06:28 INFO - 'sessionrestore', 13:06:28 INFO - 'sessionrestore_no_auto_restore', 13:06:28 INFO - 'tabpaint']}, 13:06:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:06:28 INFO - 'ts_paint', 13:06:28 INFO - 'tpaint', 13:06:28 INFO - 'sessionrestore', 13:06:28 INFO - 'sessionrestore_no_auto_restore', 13:06:28 INFO - 'tabpaint']}, 13:06:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['a11yr', 13:06:28 INFO - 'ts_paint', 13:06:28 INFO - 'tpaint', 13:06:28 INFO - 'sessionrestore', 13:06:28 INFO - 'sessionrestore_no_auto_restore', 13:06:28 INFO - 'tabpaint']}, 13:06:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['a11yr', 13:06:28 INFO - 'ts_paint', 13:06:28 INFO - 'tpaint', 13:06:28 INFO - 'sessionrestore', 13:06:28 INFO - 'sessionrestore_no_auto_restore', 13:06:28 INFO - 'tabpaint']}, 13:06:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['tsvgx', 13:06:28 INFO - 'tsvgr_opacity', 13:06:28 INFO - 'tart', 13:06:28 INFO - 'tscrollx', 13:06:28 INFO - 'cart', 13:06:28 INFO - 'tsvg_static']}, 13:06:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:06:28 INFO - 'tsvgr_opacity', 13:06:28 INFO - 'tart', 13:06:28 INFO - 'tscrollx', 13:06:28 INFO - 'cart', 13:06:28 INFO - 'tsvg_static']}, 13:06:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:06:28 INFO - 'talos_options': ['--disable-e10s'], 13:06:28 INFO - 'tests': ['tp5o']}, 13:06:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:06:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:06:28 INFO - 'talos_options': ['--disable-e10s', 13:06:28 INFO - '--xperf_path', 13:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:28 INFO - 'tests': ['tp5n']}, 13:06:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:06:28 INFO - 'talos_options': ['--xperf_path', 13:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:06:28 INFO - 'tests': ['tp5n']}}, 13:06:28 INFO - 'talos.zip': {'path': '', 13:06:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:06:28 INFO - Running post-action listener: _resource_record_post_action 13:06:28 INFO - [mozharness: 2017-01-07 21:06:28.122980Z] Finished populate-webroot step (success) 13:06:28 INFO - [mozharness: 2017-01-07 21:06:28.123069Z] Running create-virtualenv step. 13:06:28 INFO - Running pre-action listener: _resource_record_pre_action 13:06:28 INFO - Running main action method: create_virtualenv 13:06:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:06:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:06:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:06:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:06:28 INFO - Using real prefix '/usr' 13:06:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:06:28 INFO - Installing distribute.............................................................................................................................................................................................done. 13:06:30 INFO - Installing pip.................done. 13:06:30 INFO - Return code: 0 13:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:06:30 INFO - Reading from file tmpfile_stdout 13:06:30 INFO - Output received: 13:06:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:06:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:30 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:30 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 13:06:30 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 13:06:30 INFO - Using env: {'DISPLAY': ':0', 13:06:30 INFO - 'HOME': '/home/cltbld', 13:06:30 INFO - 'LANG': 'en_US.UTF-8', 13:06:30 INFO - 'LANGUAGE': 'en_US:en', 13:06:30 INFO - 'LOGNAME': 'cltbld', 13:06:30 INFO - 'MAIL': '/var/mail/cltbld', 13:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:30 INFO - 'MOZ_NO_REMOTE': '1', 13:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:30 INFO - 'NO_EM_RESTART': '1', 13:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:30 INFO - 'PWD': '/builds/slave/test', 13:06:30 INFO - 'SHELL': '/bin/bash', 13:06:30 INFO - 'SHLVL': '1', 13:06:30 INFO - 'TERM': 'linux', 13:06:30 INFO - 'TMOUT': '86400', 13:06:30 INFO - 'USER': 'cltbld', 13:06:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:30 INFO - '_': '/tools/buildbot/bin/python'} 13:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:06:31 INFO - Cleaning up... 13:06:31 INFO - Return code: 0 13:06:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:06:31 INFO - Using env: {'DISPLAY': ':0', 13:06:31 INFO - 'HOME': '/home/cltbld', 13:06:31 INFO - 'LANG': 'en_US.UTF-8', 13:06:31 INFO - 'LANGUAGE': 'en_US:en', 13:06:31 INFO - 'LOGNAME': 'cltbld', 13:06:31 INFO - 'MAIL': '/var/mail/cltbld', 13:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:31 INFO - 'MOZ_NO_REMOTE': '1', 13:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:31 INFO - 'NO_EM_RESTART': '1', 13:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:31 INFO - 'PWD': '/builds/slave/test', 13:06:31 INFO - 'SHELL': '/bin/bash', 13:06:31 INFO - 'SHLVL': '1', 13:06:31 INFO - 'TERM': 'linux', 13:06:31 INFO - 'TMOUT': '86400', 13:06:31 INFO - 'USER': 'cltbld', 13:06:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:31 INFO - '_': '/tools/buildbot/bin/python'} 13:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:31 INFO - Downloading/unpacking psutil>=3.1.1 13:06: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 13:06: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 13:06: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 13:06: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 13:06: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 13:06: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 13:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:33 INFO - Installing collected packages: psutil 13:06:33 INFO - Running setup.py install for psutil 13:06:33 INFO - building 'psutil._psutil_linux' extension 13:06:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:06:33 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 13:06:33 INFO - building 'psutil._psutil_posix' extension 13:06:33 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 13:06:33 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 13:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:06:33 INFO - Successfully installed psutil 13:06:33 INFO - Cleaning up... 13:06:34 INFO - Return code: 0 13:06:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:06:34 INFO - Using env: {'DISPLAY': ':0', 13:06:34 INFO - 'HOME': '/home/cltbld', 13:06:34 INFO - 'LANG': 'en_US.UTF-8', 13:06:34 INFO - 'LANGUAGE': 'en_US:en', 13:06:34 INFO - 'LOGNAME': 'cltbld', 13:06:34 INFO - 'MAIL': '/var/mail/cltbld', 13:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:34 INFO - 'MOZ_NO_REMOTE': '1', 13:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:34 INFO - 'NO_EM_RESTART': '1', 13:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:34 INFO - 'PWD': '/builds/slave/test', 13:06:34 INFO - 'SHELL': '/bin/bash', 13:06:34 INFO - 'SHLVL': '1', 13:06:34 INFO - 'TERM': 'linux', 13:06:34 INFO - 'TMOUT': '86400', 13:06:34 INFO - 'USER': 'cltbld', 13:06:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:34 INFO - '_': '/tools/buildbot/bin/python'} 13:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:06:36 INFO - Installing collected packages: mozsystemmonitor 13:06:36 INFO - Running setup.py install for mozsystemmonitor 13:06:36 INFO - Successfully installed mozsystemmonitor 13:06:36 INFO - Cleaning up... 13:06:36 INFO - Return code: 0 13:06:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:06:36 INFO - Using env: {'DISPLAY': ':0', 13:06:36 INFO - 'HOME': '/home/cltbld', 13:06:36 INFO - 'LANG': 'en_US.UTF-8', 13:06:36 INFO - 'LANGUAGE': 'en_US:en', 13:06:36 INFO - 'LOGNAME': 'cltbld', 13:06:36 INFO - 'MAIL': '/var/mail/cltbld', 13:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:36 INFO - 'MOZ_NO_REMOTE': '1', 13:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:36 INFO - 'NO_EM_RESTART': '1', 13:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:36 INFO - 'PWD': '/builds/slave/test', 13:06:36 INFO - 'SHELL': '/bin/bash', 13:06:36 INFO - 'SHLVL': '1', 13:06:36 INFO - 'TERM': 'linux', 13:06:36 INFO - 'TMOUT': '86400', 13:06:36 INFO - 'USER': 'cltbld', 13:06:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:36 INFO - '_': '/tools/buildbot/bin/python'} 13:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:36 INFO - Downloading/unpacking jsonschema==2.5.1 13:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:06:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:38 INFO - Downloading functools32-3.2.3-2.tar.gz 13:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:06:38 INFO - warning: no files found matching '*.txt' 13:06:38 INFO - no previously-included directories found matching 'build' 13:06:38 INFO - no previously-included directories found matching 'dist' 13:06:38 INFO - no previously-included directories found matching '.git*' 13:06:38 INFO - Installing collected packages: jsonschema, functools32 13:06:39 INFO - Running setup.py install for functools32 13:06:39 INFO - warning: no files found matching '*.txt' 13:06:39 INFO - no previously-included directories found matching 'build' 13:06:39 INFO - no previously-included directories found matching 'dist' 13:06:39 INFO - no previously-included directories found matching '.git*' 13:06:39 INFO - Successfully installed jsonschema functools32 13:06:39 INFO - Cleaning up... 13:06:39 INFO - Return code: 0 13:06:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:06:39 INFO - Using env: {'DISPLAY': ':0', 13:06:39 INFO - 'HOME': '/home/cltbld', 13:06:39 INFO - 'LANG': 'en_US.UTF-8', 13:06:39 INFO - 'LANGUAGE': 'en_US:en', 13:06:39 INFO - 'LOGNAME': 'cltbld', 13:06:39 INFO - 'MAIL': '/var/mail/cltbld', 13:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:39 INFO - 'MOZ_NO_REMOTE': '1', 13:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:39 INFO - 'NO_EM_RESTART': '1', 13:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:39 INFO - 'PWD': '/builds/slave/test', 13:06:39 INFO - 'SHELL': '/bin/bash', 13:06:39 INFO - 'SHLVL': '1', 13:06:39 INFO - 'TERM': 'linux', 13:06:39 INFO - 'TMOUT': '86400', 13:06:39 INFO - 'USER': 'cltbld', 13:06:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:39 INFO - '_': '/tools/buildbot/bin/python'} 13:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:06:39 INFO - Cleaning up... 13:06:39 INFO - Return code: 0 13:06:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:06:39 INFO - Using env: {'DISPLAY': ':0', 13:06:39 INFO - 'HOME': '/home/cltbld', 13:06:39 INFO - 'LANG': 'en_US.UTF-8', 13:06:39 INFO - 'LANGUAGE': 'en_US:en', 13:06:39 INFO - 'LOGNAME': 'cltbld', 13:06:39 INFO - 'MAIL': '/var/mail/cltbld', 13:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:39 INFO - 'MOZ_NO_REMOTE': '1', 13:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:39 INFO - 'NO_EM_RESTART': '1', 13:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:39 INFO - 'PWD': '/builds/slave/test', 13:06:39 INFO - 'SHELL': '/bin/bash', 13:06:39 INFO - 'SHLVL': '1', 13:06:39 INFO - 'TERM': 'linux', 13:06:39 INFO - 'TMOUT': '86400', 13:06:39 INFO - 'USER': 'cltbld', 13:06:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:39 INFO - '_': '/tools/buildbot/bin/python'} 13:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:39 INFO - Downloading/unpacking blobuploader==1.2.4 13:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:41 INFO - Downloading blobuploader-1.2.4.tar.gz 13:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:06:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:06:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:42 INFO - Downloading docopt-0.6.1.tar.gz 13:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:06:42 INFO - Installing collected packages: blobuploader, requests, docopt 13:06:42 INFO - Running setup.py install for blobuploader 13:06:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:06:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:06:42 INFO - Running setup.py install for requests 13:06:42 INFO - Running setup.py install for docopt 13:06:42 INFO - Successfully installed blobuploader requests docopt 13:06:42 INFO - Cleaning up... 13:06:43 INFO - Return code: 0 13:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:43 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:43 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 13:06:43 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 13:06:43 INFO - Using env: {'DISPLAY': ':0', 13:06:43 INFO - 'HOME': '/home/cltbld', 13:06:43 INFO - 'LANG': 'en_US.UTF-8', 13:06:43 INFO - 'LANGUAGE': 'en_US:en', 13:06:43 INFO - 'LOGNAME': 'cltbld', 13:06:43 INFO - 'MAIL': '/var/mail/cltbld', 13:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:43 INFO - 'MOZ_NO_REMOTE': '1', 13:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:43 INFO - 'NO_EM_RESTART': '1', 13:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:43 INFO - 'PWD': '/builds/slave/test', 13:06:43 INFO - 'SHELL': '/bin/bash', 13:06:43 INFO - 'SHLVL': '1', 13:06:43 INFO - 'TERM': 'linux', 13:06:43 INFO - 'TMOUT': '86400', 13:06:43 INFO - 'USER': 'cltbld', 13:06:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:43 INFO - '_': '/tools/buildbot/bin/python'} 13:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:43 INFO - Running setup.py (path:/tmp/pip-mVJwES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:43 INFO - Running setup.py (path:/tmp/pip-uA_rKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:43 INFO - Running setup.py (path:/tmp/pip-Y6s6Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:43 INFO - Running setup.py (path:/tmp/pip-tB03O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:43 INFO - Running setup.py (path:/tmp/pip-JOPepk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:43 INFO - Running setup.py (path:/tmp/pip-9rZur2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:43 INFO - Running setup.py (path:/tmp/pip-i8o82v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:43 INFO - Running setup.py (path:/tmp/pip-dcpb6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:43 INFO - Running setup.py (path:/tmp/pip-bsUoIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:43 INFO - Running setup.py (path:/tmp/pip-MbUQjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:43 INFO - Running setup.py (path:/tmp/pip-OvEljd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:44 INFO - Running setup.py (path:/tmp/pip-JPT1y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:44 INFO - Running setup.py (path:/tmp/pip-jU2sZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:44 INFO - Running setup.py (path:/tmp/pip-lfs5gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:44 INFO - Running setup.py (path:/tmp/pip-HRh6U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:44 INFO - Running setup.py (path:/tmp/pip-FwZGzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:44 INFO - Running setup.py (path:/tmp/pip-IoMVQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:06:44 INFO - Running setup.py install for manifestparser 13:06:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:06:44 INFO - Running setup.py install for mozcrash 13:06:44 INFO - Running setup.py install for mozdebug 13:06:44 INFO - Running setup.py install for mozdevice 13:06:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:06:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:06:44 INFO - Running setup.py install for mozfile 13:06:44 INFO - Running setup.py install for mozhttpd 13:06:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozinfo 13:06:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozInstall 13:06:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozleak 13:06:45 INFO - Running setup.py install for mozlog 13:06:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for moznetwork 13:06:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozprocess 13:06:45 INFO - Running setup.py install for mozprofile 13:06:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozrunner 13:06:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:06:45 INFO - Running setup.py install for mozscreenshot 13:06:46 INFO - Running setup.py install for moztest 13:06:46 INFO - Running setup.py install for mozversion 13:06:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:06:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:06:46 INFO - Cleaning up... 13:06:46 INFO - Return code: 0 13:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:06:46 INFO - Using env: {'DISPLAY': ':0', 13:06:46 INFO - 'HOME': '/home/cltbld', 13:06:46 INFO - 'LANG': 'en_US.UTF-8', 13:06:46 INFO - 'LANGUAGE': 'en_US:en', 13:06:46 INFO - 'LOGNAME': 'cltbld', 13:06:46 INFO - 'MAIL': '/var/mail/cltbld', 13:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:46 INFO - 'MOZ_NO_REMOTE': '1', 13:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:46 INFO - 'NO_EM_RESTART': '1', 13:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:46 INFO - 'PWD': '/builds/slave/test', 13:06:46 INFO - 'SHELL': '/bin/bash', 13:06:46 INFO - 'SHLVL': '1', 13:06:46 INFO - 'TERM': 'linux', 13:06:46 INFO - 'TMOUT': '86400', 13:06:46 INFO - 'USER': 'cltbld', 13:06:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:46 INFO - '_': '/tools/buildbot/bin/python'} 13:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:06:46 INFO - Running setup.py (path:/tmp/pip-EktFfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:06:46 INFO - Running setup.py (path:/tmp/pip-wmbTb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:06:46 INFO - Running setup.py (path:/tmp/pip-6RvyGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:06:46 INFO - Running setup.py (path:/tmp/pip-GiwOep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:06:46 INFO - Running setup.py (path:/tmp/pip-ram1eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:06:46 INFO - Running setup.py (path:/tmp/pip-9KYfai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:06:46 INFO - Running setup.py (path:/tmp/pip-3QMSWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:06:46 INFO - Running setup.py (path:/tmp/pip-NW3iN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:06:47 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:06:47 INFO - Running setup.py (path:/tmp/pip-pePOlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:06:47 INFO - Running setup.py (path:/tmp/pip-fsCXJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:06:47 INFO - Running setup.py (path:/tmp/pip-QTP5bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:06:47 INFO - Running setup.py (path:/tmp/pip-nV0DQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:06:47 INFO - Running setup.py (path:/tmp/pip-7dF7Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:06:47 INFO - Running setup.py (path:/tmp/pip-Vp2Vxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:47 INFO - Running setup.py (path:/tmp/pip-DtbWHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:06:47 INFO - Running setup.py (path:/tmp/pip-n9AOcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 13:06:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:06:47 INFO - Running setup.py (path:/tmp/pip-CnSWSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:06:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:06:49 INFO - Downloading blessings-1.6.tar.gz 13:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:06:49 INFO - Installing collected packages: blessings 13:06:49 INFO - Running setup.py install for blessings 13:06:50 INFO - Successfully installed blessings 13:06:50 INFO - Cleaning up... 13:06:50 INFO - Return code: 0 13:06:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:50 INFO - Reading from file tmpfile_stdout 13:06:50 INFO - Current package versions: 13:06:50 INFO - argparse == 1.2.1 13:06:50 INFO - blessings == 1.6 13:06:50 INFO - blobuploader == 1.2.4 13:06:50 INFO - docopt == 0.6.1 13:06:50 INFO - functools32 == 3.2.3-2 13:06:50 INFO - jsonschema == 2.5.1 13:06:50 INFO - manifestparser == 1.1 13:06:50 INFO - mozInstall == 1.12 13:06:50 INFO - mozcrash == 1.0 13:06:50 INFO - mozdebug == 0.1 13:06:50 INFO - mozdevice == 0.49 13:06:50 INFO - mozfile == 1.2 13:06:50 INFO - mozhttpd == 0.7 13:06:50 INFO - mozinfo == 0.9 13:06:50 INFO - mozleak == 0.1 13:06:50 INFO - mozlog == 3.4 13:06:50 INFO - moznetwork == 0.27 13:06:50 INFO - mozprocess == 0.24 13:06:50 INFO - mozprofile == 0.28 13:06:50 INFO - mozrunner == 6.13 13:06:50 INFO - mozscreenshot == 0.1 13:06:50 INFO - mozsystemmonitor == 0.3 13:06:50 INFO - moztest == 0.8 13:06:50 INFO - mozversion == 1.4 13:06:50 INFO - psutil == 3.1.1 13:06:50 INFO - requests == 1.2.3 13:06:50 INFO - wsgiref == 0.1.2 13:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 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 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:50 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 13:06:50 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 13:06:50 INFO - Using env: {'DISPLAY': ':0', 13:06:50 INFO - 'HOME': '/home/cltbld', 13:06:50 INFO - 'LANG': 'en_US.UTF-8', 13:06:50 INFO - 'LANGUAGE': 'en_US:en', 13:06:50 INFO - 'LOGNAME': 'cltbld', 13:06:50 INFO - 'MAIL': '/var/mail/cltbld', 13:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:50 INFO - 'MOZ_NO_REMOTE': '1', 13:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:50 INFO - 'NO_EM_RESTART': '1', 13:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:50 INFO - 'PWD': '/builds/slave/test', 13:06:50 INFO - 'SHELL': '/bin/bash', 13:06:50 INFO - 'SHLVL': '1', 13:06:50 INFO - 'TERM': 'linux', 13:06:50 INFO - 'TMOUT': '86400', 13:06:50 INFO - 'USER': 'cltbld', 13:06:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:50 INFO - '_': '/tools/buildbot/bin/python'} 13:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:06:50 INFO - Cleaning up... 13:06:50 INFO - Return code: 0 13:06:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:06:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ad480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, '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': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', '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 13:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:06:50 INFO - Using env: {'DISPLAY': ':0', 13:06:50 INFO - 'HOME': '/home/cltbld', 13:06:50 INFO - 'LANG': 'en_US.UTF-8', 13:06:50 INFO - 'LANGUAGE': 'en_US:en', 13:06:50 INFO - 'LOGNAME': 'cltbld', 13:06:50 INFO - 'MAIL': '/var/mail/cltbld', 13:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:06:50 INFO - 'MOZ_NO_REMOTE': '1', 13:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:06:50 INFO - 'NO_EM_RESTART': '1', 13:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:06:50 INFO - 'PWD': '/builds/slave/test', 13:06:50 INFO - 'SHELL': '/bin/bash', 13:06:50 INFO - 'SHLVL': '1', 13:06:50 INFO - 'TERM': 'linux', 13:06:50 INFO - 'TMOUT': '86400', 13:06:50 INFO - 'USER': 'cltbld', 13:06:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:06:50 INFO - '_': '/tools/buildbot/bin/python'} 13:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:06:50 INFO - Cleaning up... 13:06:50 INFO - Return code: 0 13:06:50 INFO - Running post-action listener: _resource_record_post_action 13:06:50 INFO - Running post-action listener: _start_resource_monitoring 13:06:50 INFO - Starting resource monitoring. 13:06:50 INFO - [mozharness: 2017-01-07 21:06:50.812396Z] Finished create-virtualenv step (success) 13:06:50 INFO - [mozharness: 2017-01-07 21:06:50.812891Z] Running install step. 13:06:50 INFO - Running pre-action listener: _resource_record_pre_action 13:06:50 INFO - Running main action method: install 13:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:06:51 INFO - Reading from file tmpfile_stdout 13:06:51 INFO - Detecting whether we're running mozinstall >=1.0... 13:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:06:51 INFO - Reading from file tmpfile_stdout 13:06:51 INFO - Output received: 13:06:51 INFO - Usage: mozinstall [options] installer 13:06:51 INFO - Options: 13:06:51 INFO - -h, --help show this help message and exit 13:06:51 INFO - -d DEST, --destination=DEST 13:06:51 INFO - Directory to install application into. [default: 13:06:51 INFO - "/builds/slave/test"] 13:06:51 INFO - --app=APP Application being installed. [default: firefox] 13:06:51 INFO - mkdir: /builds/slave/test/build/application 13:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:07:07 INFO - Reading from file tmpfile_stdout 13:07:07 INFO - Output received: 13:07:07 INFO - /builds/slave/test/build/application/firefox/firefox 13:07:07 INFO - Running post-action listener: _resource_record_post_action 13:07:07 INFO - [mozharness: 2017-01-07 21:07:07.342735Z] Finished install step (success) 13:07:07 INFO - [mozharness: 2017-01-07 21:07:07.343008Z] Running run-tests step. 13:07:07 INFO - Running pre-action listener: _resource_record_pre_action 13:07:07 INFO - Running main action method: run_tests 13:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:07:07 INFO - Python 2.7.3 13:07:07 INFO - Return code: 0 13:07:07 INFO - grabbing minidump binary from tooltool 13:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:07:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27aa820>, '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 0x27ab520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ab9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:07:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:07:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:07:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:07:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:07:07 INFO - Return code: 0 13:07:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:07:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:07:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:07:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:07:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 13:07:07 INFO - Using env: {'DISPLAY': ':0', 13:07:07 INFO - 'HOME': '/home/cltbld', 13:07:07 INFO - 'LANG': 'en_US.UTF-8', 13:07:07 INFO - 'LANGUAGE': 'en_US:en', 13:07:07 INFO - 'LOGNAME': 'cltbld', 13:07:07 INFO - 'MAIL': '/var/mail/cltbld', 13:07:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:07:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:07 INFO - 'MOZ_NO_REMOTE': '1', 13:07:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:07 INFO - 'NO_EM_RESTART': '1', 13:07:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:07 INFO - 'PWD': '/builds/slave/test', 13:07:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:07:07 INFO - 'SHELL': '/bin/bash', 13:07:07 INFO - 'SHLVL': '1', 13:07:07 INFO - 'TERM': 'linux', 13:07:07 INFO - 'TMOUT': '86400', 13:07:07 INFO - 'USER': 'cltbld', 13:07:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776', 13:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:07 INFO - '_': '/tools/buildbot/bin/python'} 13:07:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:07:07 INFO - mozversion application_buildid: 20170107203201 13:07:07 INFO - mozversion application_changeset: f40258de5ee269f22833bdcc36dff621814349cd 13:07:07 INFO - mozversion application_display_name: Nightly 13:07:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:07:07 INFO - mozversion application_name: Firefox 13:07:07 INFO - mozversion application_remotingname: firefox 13:07:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:07:07 INFO - mozversion application_vendor: Mozilla 13:07:07 INFO - mozversion application_version: 53.0a1 13:07:07 INFO - mozversion platform_buildid: 20170107203201 13:07:07 INFO - mozversion platform_changeset: f40258de5ee269f22833bdcc36dff621814349cd 13:07:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:07:07 INFO - mozversion platform_version: 53.0a1 13:07:07 INFO - using testdate: 1483823227 13:07:07 INFO - actual date: 1483823227 13:07:07 INFO - starting webserver on 'localhost:59890' 13:07:07 INFO - SUITE-START | Running 2 tests 13:07:07 INFO - TEST-START | dromaeo_css 13:07:07 INFO - operating with platform_type : linux_ 13:07:07 INFO - Initialising browser for dromaeo_css test... 13:07:07 INFO - TEST-INFO | started process 11200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp27Wttn/profile http://localhost:59890/getInfo.html) 13:07:08 INFO - PROCESS | 11200 | 1483823228151 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 13:07:12 INFO - PROCESS | 11200 | __metrics Screen width/height:1600/1200 13:07:12 INFO - PROCESS | 11200 | colorDepth:24 13:07:12 INFO - PROCESS | 11200 | Browser inner width/height: 1024/697 13:07:12 INFO - PROCESS | 11200 | __metrics 13:07:13 ERROR - PROCESS | 11200 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 13:07:13 INFO - TEST-INFO | 11200: exit 0 13:07:13 INFO - Browser initialized. 13:07:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:07:13 INFO - TEST-INFO | started process 11321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp27Wttn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:07:26 INFO - PROCESS | 11321 | RSS: Main: 158511104 13:07:26 INFO - PROCESS | 11321 | 13:10:29 INFO - PROCESS | 11321 | Cycle 1(1): loaded http://localhost:59890/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59890/tests/dromaeo/cssquery-ext.html) 13:10:31 INFO - PROCESS | 11321 | RSS: Main: 166395904 13:10:31 INFO - PROCESS | 11321 | 13:12:14 INFO - PROCESS | 11321 | ************************* 13:12:14 INFO - PROCESS | 11321 | A coding exception was thrown and uncaught in a Task. 13:12:14 INFO - PROCESS | 11321 | 13:12:14 INFO - PROCESS | 11321 | Full message: ReferenceError: fetch is not defined 13:12:14 INFO - PROCESS | 11321 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 13:12:14 INFO - PROCESS | 11321 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 13:12:14 INFO - PROCESS | 11321 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 13:12:14 INFO - PROCESS | 11321 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 13:12:14 INFO - PROCESS | 11321 | TaskImpl@resource://gre/modules/Task.jsm:277:3 13:12:14 INFO - PROCESS | 11321 | asyncFunction@resource://gre/modules/Task.jsm:252:14 13:12:14 INFO - PROCESS | 11321 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 13:12:14 INFO - PROCESS | 11321 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 13:12:14 INFO - PROCESS | 11321 | TaskImpl@resource://gre/modules/Task.jsm:277:3 13:12:14 INFO - PROCESS | 11321 | asyncFunction@resource://gre/modules/Task.jsm:252:14 13:12:14 INFO - PROCESS | 11321 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 13:12:14 INFO - PROCESS | 11321 | 13:12:14 INFO - PROCESS | 11321 | ************************* 13:13:33 INFO - PROCESS | 11321 | Cycle 1(1): loaded http://localhost:59890/tests/dromaeo/cssquery-ext.html (next: http://localhost:59890/tests/dromaeo/cssquery-jquery.html) 13:13:34 INFO - PROCESS | 11321 | RSS: Main: 163323904 13:13:34 INFO - PROCESS | 11321 | 13:16:36 INFO - PROCESS | 11321 | Cycle 1(1): loaded http://localhost:59890/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59890/tests/dromaeo/cssquery-mootools.html) 13:16:37 INFO - PROCESS | 11321 | RSS: Main: 168800256 13:16:37 INFO - PROCESS | 11321 | 13:19:39 INFO - PROCESS | 11321 | Cycle 1(1): loaded http://localhost:59890/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59890/tests/dromaeo/cssquery-prototype.html) 13:19:39 INFO - PROCESS | 11321 | RSS: Main: 163532800 13:19:39 INFO - PROCESS | 11321 | 13:22:42 INFO - PROCESS | 11321 | Cycle 1(1): loaded http://localhost:59890/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59890/tests/dromaeo/cssquery-yui.html) 13:22:43 INFO - PROCESS | 11321 | RSS: Main: 167002112 13:22:43 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | Cycle 1(1): loaded http://localhost:59890/tests/dromaeo/cssquery-yui.html (next: http://localhost:59890/tests/dromaeo/cssquery-dojo.html) 13:25:46 INFO - PROCESS | 11321 | RSS: Main: 167301120 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | __start_tp_report 13:25:46 INFO - PROCESS | 11321 | _x_x_mozilla_page_load 13:25:46 INFO - PROCESS | 11321 | _x_x_mozilla_page_load_details 13:25:46 INFO - PROCESS | 11321 | |i|pagename|runs| 13:25:46 INFO - PROCESS | 11321 | |0;dojo.html;2605.283547024568;2618.581027035674;2635.7364263573645;2637.222019504246;2655.94688106238;4786.540105267892;4898.926516102261;4907.043126590316;4918.8770280743;4920.778564964577;4841;4855.441624213207;4894.314795928564;4906.63200259981;4978.402591689002;4417.889552761175;4460.643148548108;4479.910401791963;4537.795799189028;4580.015296711206;4158.688098392618;4625.5836974672275;4652.302154676791;4653.441587009564;4673.3223682566;4445.755483448409;4457.2199865023495;4473.552644735533;4522.570355816192;4571.862844114682;4397.120575884804;4407.933880991788;4441.111777644484;4461.196984542781;4525.683202175849;4433.933490997605;4443.844465443726;4454.13144436835;4459.152760975437;4485.349624304457;4777.378940737716;4800.183968725325;4805.063012712522;4823.758812059383;4836.806527738886;5134.460881607452;5203.505666961671;5223.608229382811;5246.685198888041;5275.155975044013;5322.361316641989;5330.040592693314;5333.57331413486;5333.946660533384;5404.729763511808;4959.776810043557;4965.478624744422;4980.850574482772;5001.24981252815;5042.193249080166;5287.603429742785;5288.418273989858;5305.389880163753;5412.242286079952;5431.266778984866;5127.769250383742;5149.6910185389;5177.145770947826;5180.922286165711;5184.248283998874;5226.738663066832;5255.290535777697;5259.15853463444;5274.5780337572905;5275.60432967529;5101.770420331094;5139.203423469368;5170.069387510209;5174.689518628894;5193.272941788153;5164.586833053347;5167.974160129175;5168.53483186515;5183.403908550489;5210.947890521122;4222.936655950163;4280.978595107067;4299.441072660534;4303.291953610868;4342.413774140514;3647.179384638488;3663.2673465307043;3669.798161101165;3717.20080182762;3731.477593136963;4374.890627734332;4380.080183161508;4384.4300240969105;4400.9119817604105;4417.2269852775635;5125.974805038933;5126.846194614168;5127.2052831811125;5140.3831540215415;5192.870178245498;4435.6229720473475;4439.045605194834;4454.910901781946;4476.239039363316;4481.260592002283;4706.411698537683;4709.81160753566;4709.858704238878;4716.127516409407;4758.07217592573;4876.536729010738;4889.804407823647;4890.828820991248;4892.657513973988;4931.4328852181025;5161.819336323361;5207.270982062439;5223.138182200047;5243.292155558951;5264.499872512105;4893.853184404474;4896.216605343128;4902.656814023127;4907.460179380337;4955.083309587738;5095.668781529189;5135.537801597874;5152;5215.374155101412;5232.555232805102;5165.535101840853;5261.631685781958;5273.499017593323;5290.047791397586;5300.284461597789;5005.499450054966;5014.34813474246;5018.422881368543;5020.221865610836;5108.412532558803;5051.974740126423;5057.31726216956;5075.670081444694;5105.591552675852;5109.386873575195;4945.2582112683385;4947.579455746302;4948.851534453972;4959.355283813081;4991.700497970133;5066.645334826527;5090.516400941905;5102.10713125209;5102.727268197105;5119.360079990001;5022.698638081727;5023.2214006829;5032.672876263177;5034.421041580119;5073.6702114363925 13:25:46 INFO - PROCESS | 11321 | |1;ext.html;495.6976244490861;500.9398872135344;503.71791796593885;508.9770960306786;520.6927912531605;37274.25451490972;39388;39430.2113957721;42664;42665.57334426655;40372.39441408374;40841;40951.180976380456;41060.38409423861;41142;7698.923010769877;7891.289783919446;7891.881621775678;7894.842103157934;7905.841883162362;9271.25829933607;9527.285453590974;9564.808703825955;9786.26603004774;9797.951010244975;9367.203787678056;9421.576029078708;9422.199113075363;9426.34015618907;9434.858477122849;9127.817443651124;9195.172434480863;9197.908020919805;9210.585523651385;9231.169194772503;9610.807783844353;9669.371490853073;9676.75808104796;9678.661246856396;9715.90284097157;34679.82660086708;34738.65261347405;34761.30477390463;34785.82607086949;34791.82604086964;3608.260306637133;3667.7982710950887;3678.08047988003;3681.4845921571;3716.4982727331735;25722.228333150037;26218.21345359642;26323;26419.867900660374;26647.20058398251;3404.557407537029;3408.454647256452;3432.5709286339206;3484.372812893678;3496.720262379029;233488;236506;236898.5721713388;236949;236963.81518092472;46773;46930.5306946933;46992.5300746995;47053.764731176125;47079;48162;48182.518174818506;48366.75816620965;48469.515304847206;48497.75751121222;11689.123315751183;12151.756964860653;12162.391880406121;12168.45241964096;12181.33002684861;7831.882521762178;8020.157883422274;8488.236058754741;8497.150284971452;8498.277646400125;15537.766933496006;15990.120543369994;15997.60005999836;16014.119223442822;16143.273552689921;6317.557770955989;6437.2918978912285;6446.967765161145;6550.3972814951585;6569.37590928861;782.4366456151562;785.8664027115404;792.6551949901811;793.0562630469723;809.8501777171242;27582.862085689845;28331;28346.574801377996;28582;28647.775045609647;974.8878878928872;975.9853602195973;981.9607215711435;982.3712823792779;1118.959367787965;15128.621784455256;15224.695506090038;15258.694826103416;15284.159371234466;15509.5347139586;367532;381710;382469;556979;559549;43379.34930976038;43620.56379436165;43643.99999999937;43657.34513982293;43706.78146609246;1233.8457692788402;1253.8088815625192;1273.1533530202496;1274.1908887856277;1274.7577960187534;25015.874920626007;25775.484490309715;26252.343691407103;26309.605355919295;26568;37704.622953771206;38074.80962595169;38125;38151.23697525978;38216.80891595524;251199;253257;254446;254516;254863;23547.52904941926;23948.365679774863;24003.759962400152;24042.278731638078;24368.6344704826;37130.44304335383;37161.4425783608;37867.62132378641;38156;38301.61698382981;32321;32384.67615323911;32838;32980.50529242015;33130.5030424539;31359;31879.521807173376;32653.428520006742;32711;33177;31744.433031841825;31899.68100318967;31999;31999;32037.839810800797;27978;28660.713392866637;29436.116916492538;29669.25826854346;29890.72753636225;22817.31548053561;22835.771642284028;22919.885400573556;22959.42601434911;23145.88427057854 13:25:46 INFO - PROCESS | 11321 | |2;jquery.html;353.6163262859797;366.73961487343985;368.43445311446936;369.81658692185005;387.3666555182276;16943.999999999985;18262.634747305063;18761.437156885317;18931.62136757264;18999.240030398767;16504.174791260448;17984.73022904654;18128.54678633035;18211.72682409765;18736;5050.888804463012;5212.113940630083;5271.813841885583;5273.446288139748;5284.180951952434;5043.949560504403;5212.478752124795;5235.345581802275;5242.711650859202;5256.737163141827;5187.455317191697;5192.506711862386;5209.374875014984;5214.191800270964;5218.921716174261;5015.473375295596;5143.614228932807;5159.251908473269;5182.922256166161;5196.376434827807;4591.586757191869;4632.745199014053;4646.094011667727;4646.186917289461;4649.5350464953235;21793.67309490359;21794.89102554477;21960.780392196033;22030;22239.777602223934;2207.249535158054;2249.718785151856;2253.0649780341137;2273.056681477185;2329.77867102625;14028.298585070706;14031;14236.359363828653;14295.142291462545;14628.195449250286;1702.5232934778282;1702.5658457093487;1714.8542373898233;1733.9913300433543;1751.842334189929;78747;81094.59452702758;81804;84024;85149.57425212896;10013.749656258651;10067.194624430029;10342;10389.428581428094;10395.428251446092;13906.860931390556;13986.440542378394;14023.158610483404;14302.57092287233;14392.856071439151;6585.6377899216;6762.966185169141;6896.724131034703;6897.62063086525;6929.480288978347;6157.384261573807;6157.538184636171;6205.968970155121;6329.875948642581;6383.968080159662;4254.361845723104;4323.675724320626;4397.428334316518;4515.390422293014;4531.909361812811;1774.9023803690663;1819.7543331650058;1855.9721604175948;1860.8976506292013;1873.3443294846695;895.2927187521915;985.556499575194;990.7269159130627;996.5067291690659;1014.7260239735377;17775.444911017847;18225.270989160286;18387.632247354977;18436.631267374847;18773.530661733294;929.809389075238;940.9294302927308;952.2667545989688;962.3071388600197;970.9611615535299;9702.5148742564;9833.950830245803;9990.600375984879;10174.847377289347;10230.64192753265;487267;494184;494560;495144;502375;69465.65267173733;77912.61043694745;87357;87570.56214718886;89055;909.1908201700492;924.4037595750704;946.0586716217408;952.8618350339301;953.8759961204998;14939.626509337353;15371.385144594538;15497.380104795682;15893.443729469413;16172.272247749115;38815;39880.20239595134;39892.800535997136;40264.59735402608;40949.1810163801;58231.70884145552;58475.70762146332;59637.70181149067;61286.38713612807;61906.380936190064;7268.818279543054;7450.403967682681;7467.850642987001;7772.922270777446;7889.3826765511785;11905.523779049088;12136.575219867262;12269.93865030669;12388.380580971096;12588.30764307972;10039.397636141855;10358.399427514914;10420.947895260475;10503.527341269508;10670.146388289073;10701.678949631523;10703.892961070289;10731.248812583044;10844.891551084389;10975.28660637056;10783.838242426527;10789.946050269698;10803.621873234399;10859.674209773719;11454.541818327174;7658.502197357154;7686.961565192362;7825.413094018085;7927.682892684228;8122.309603683517;7597.772066838003;9589.42463452195;10565.154787617126;10704.250702451065;10933.890661093288 13:25:46 INFO - PROCESS | 11321 | |3;mootools.html;1300.7918733002716;1304.2174695182885;1305.699689071513;1317.2030921292617;1321.9801702974455;6284.214473190851;6375.458086062685;6495.058216558608;6699.899501507482;6725.831854203641;6605.141331626882;6912.896306555405;6927;7013.894791578117;7123.643817809115;2079.9480012999684;2112.4613223627953;2128.723265975421;2130.957380852382;2132.8826914519695;2063.38098570429;2076.9376918692465;2130.925417610384;2138.6685063815135;2170.8263338932925;2097.4127244371603;2112.9154833806706;2114.37625900359;2119.152339064371;2119.6926445665367;1977.9505512362307;2011.6580181369202;2017.6065667194903;2020.070767446976;2020.9393718188478;2108.2515706924128;2116.8412369072225;2122.1193204819983;2130.20117455954;2132.051237199447;7229.638518074128;7266.854662906712;7307.269273072703;7328.083989501312;7330.963345183293;4312.805923733439;4478.552144785528;4482.618977386926;4484.148011877733;4485.0805584855025;2697.082991782803;2806.1581525542256;2834.5606431003225;2873.5833304170988;2888.140740666746;1163.3194581170026;1177.170095082973;1634.1094103713506;1639.385230538548;1764.938227162056;9218;9286.164245217895;9298.070192980715;9299.209567186797;9325;3849.9230015400094;3857.035741064734;3931;3979.064919743858;4042.0501182222156;7456.105267367951;7500.962495187489;7529.849403012018;7575.318221359994;7640.3505702015955;4335.393044973706;4346.304591265382;4356.150550642595;4366.388705581221;4423.424954755926;3977.443157957888;4073.3889916512762;4083.060895993938;4137.234611596864;4153.231652144363;3201.2797120648133;3231.2245061185145;3247.7077063063966;3290.3583801159025;3306.2891478331794;911.4850109688005;922.2299380017761;924.523870206844;962.9711108666751;981.7545613596601;814.1614137438448;824.7072289337319;838.7892778253135;854.5812551849549;858.587877818638;4462.174497717932;4481.551844815493;4617.699849509771;4623.237165867661;4708.340832283483;867.3581549653211;909.6315992023241;920.6317473010715;922.2017066719923;924.4360939826701;3138.5919830422354;3142.3872344892984;3148.795328303653;3227.661095584977;3260.55982442372;8270.545120018336;8370.958145209235;8499.40504164715;8505.064442911274;8521.10528394522;8310.252077313071;8332.750017499484;8418.074011858691;8426.41015128935;8451.45065570736;6581;6624.8012559623285;6632.966835165793;6643.40209381158;6730.663466826639;4480.171168333869;4729.976350118227;4840.515948405131;4937.777799998937;4982.053409852117;7653.158152603098;7709.8843517348405;7744.186860379805;7759.262870027338;7773.572453515111;7286.599237042014;7551.73568925085;7637.88543171864;7717.729879454417;7833.216678332121;6170.382961703794;6264.937350626436;6292.2134733158355;6331.556791024584;6362.713677884413;6735.62954037513;6771.255161932282;6802.591844489347;6836.008778726958;6848.520603557703;5958.940410595838;6034.607750496204;6067.696615169312;6075.939240607538;6186.597871138361;5822.5633077518505;5877.588568800143;5905.616134951214;5953.434423729739;6012.969935150296;5598.692071936082;5698.287714035746;5711.457411545896;5720.027595308724;5743.59794814359;3946.881593552198;3959.8020098994357;3987.6211759882763;4010.1177740896956;4081.8979525510913;4114.7942602870335;4177;4217.135487225173;4236.5339812621205;4262.87211383659 13:25:46 INFO - PROCESS | 11321 | |4;prototype.html;339.5365326329561;344.91867993839315;349.43566140682805;352.90118766745314;358.92642008388265;4925.1627223372025;4981.352424184855;5032.270320803481;5064.417591976924;5075.695458272502;4895.926561101577;4938;4958.975205123978;4961.776720047597;4981.975090124544;3869.9806500967456;3870.342041852885;3879.3792993121106;3884.514435695538;3886.24218277436;3773.7735735855936;3870.9419358709642;3871.9806400967955;3872.8838134856;3878.9030274243228;3809.7904615246152;3828.693704503647;3829.5213098362706;3830.3105441020607;3835.654791068803;3789.5831458539537;3798.2403519295976;3808.9809550952345;3813.40892161714;3817.8091095445116;3332.133645252228;3334.1331253873923;3334.483155110962;3336.5328853960223;3338.916527086818;4602.953970460286;4813.951860481386;4830.178869592178;4867.78094985723;4872.634552408584;4395.978020109911;4404.911901761947;4406.955930440687;4422.358757980107;4424.513303536608;5220.207189153823;5232.29950266165;5261.263423120766;5265.578753699695;5272.947270527284;3454;3653.3971894637352;3660.4509323601405;3664.1022949377575;3667.826295585414;5378.973105134489;5440;5443.305563745931;5444.537214336826;5447.972760136214;3696.611855755161;3713.7586056906216;3717.423799311111;3722.6091260417807;3724.8137593120236;3735.402335626287;3739.476473293741;3751.606081361472;3757;3785.356489396754;4114.835406583703;4323.670773504384;4343.522212556616;4386.736795792199;4403.933940990888;5249.527542521191;5257.369115706139;5264.894702106013;5265.6050796189675;5282.234076059027;1234.469258119925;1263.9304838233802;1264.5141958199263;1273.4969686973593;1282.2434763489587;823.838387873096;849.4521033933202;854.6154230596256;862.4652715316544;864.9361285618725;4383.364412160219;4389.495208051051;4402.427684401007;4402.779861006937;4406.691531592822;5189.273501709764;5190.8183213587345;5202.92195617066;5221.269022336875;5223.347081614798;4384.4300240969105;4388;4408.426904502394;4411.713238639478;4419.64642828573;2631.2632462910415;2752.843805601652;2768.820026698258;2774.320291528548;2782.3739658577065;4757.690750101232;4789.688670236424;4797.488791030814;4803.639727020487;4825.469198388175;5127.564157046618;5301.879248300711;5318.574514038867;5319.6808191508635;5354.223637572608;4762.976185119052;4781.545753153376;4808.2547205183255;4813.518648135158;4829;5167.431582525995;5182.714950677749;5192.870178245423;5193.818596189685;5237.895242095061;4998.225275082368;5076.6446348755235;5101.0308041472;5135.818761684759;5184.6409883502165;4778.064883722098;4804.543568361;4808.869915569909;4851.549967266508;4855.295982082649;3584.336897673939;3602.8919132426067;3603.4955106284615;3612.2414292998765;3630.6929505377516;4860.3195552621955;5176.948230517647;5210.947890521046;5211.6710238888845;5225.346831646044;4908.171626131623;5009.849704508871;5019.598432125348;5028.698278103326;5048.823291184791;4987.476314986874;5001.899962000667;5006.499350064964;5011.924821127613;5031.798728050837;4851.805927762991;4955.479674634255;4963.801447942042;4967.776450059829;4969.378827646544;5241.135212689864;5259.684418934723;5268.2624432578705;5276.2349459327415;5283.815066472809;5100.26046223303;5133.178691409356;5139.177731562932;5148.665336753099;5152.690838549699 13:25:46 INFO - PROCESS | 11321 | |5;yui.html;592.8962431574479;610.282917571853;713.1477883928704;771.8649236383632;777.7783331750452;11372.829407558884;12144.149909506337;12186.268823870563;12227.327496987662;13926.30368481577;14790.112593244412;15115.546533603982;15876;15888.682226355466;15905;792.5284455748834;815.2621877201112;818.2267756969666;820.6143112737004;823.4030328012203;786.5477350523472;803.0323460230409;809.8056466448039;810.0401024785648;822.4489591973362;853.6244052616829;855.2943821347413;857.4640849469082;858.047567200407;858.3776761847673;852.0201767966826;853;853.036069241759;853.9914600853974;854.2695994924312;621.8134559632138;624.1168746224088;624.2103738770459;624.2477814233882;624.3631495874229;13755.79366309506;13762.174269543859;14262.144271343752;14269.215193164371;14389.568312950629;11606.593769218121;12519.687007824787;12572.497100115985;12812;12888.871111288861;10832.72918177044;10858.185636077247;10922.1808364373;10946.17903657221;10965.50655220517;3309.834508274577;3318.734501239895;3337.365900478901;3342.097633638928;3352.865885364607;64989;65825.67087164581;66812.33187668158;67322.66338668275;67651.66174169097;9200.35597508168;9362.578683959238;9413.48225847585;9414.246860251164;9541.666041688508;16530.173491325626;16827.74758378625;17696.203670834584;18210.63578728418;18337.541561460803;6671.733130674816;6831.316868313129;6880.965595171992;6887.345702158287;7080.822979425452;3608.548931383577;3661;3676.1544844685873;3707.2029513654693;3741.7380783344906;2821.2523681224493;2866.756325712338;2889.4943384907556;2890.8410037448143;2893.363460038788;455.76072561905266;465.8765427161805;469.9318598803154;524.1665751455205;556.9387367389584;589.3311091910626;621.6456619726713;623.9032949892774;629.5907660021023;638.2118084166051;8707.782305442288;8805.955970220237;9030.593623286968;9042.909570904338;9196.022315787312;583.4952765857503;591.6598903483613;595.85401576614;599.12228585123;602.9306629737637;4308.267594508941;4417.867463976086;4451.755153466525;4468.352088947149;4510.909781804411;66060;66210.33789662042;69282;69637.65181174062;69733;46057.30914036292;58472.70763646239;59352.70323648354;60250;60264;52043.73978130085;52165.7391713039;52958;54491.18263226055;54643.72678136663;8359.247667709935;8613.31093512505;8692.913070869463;8849.292056635324;9664.178544823488;33045.66954330426;34041;34919.301613968084;36657.08357291089;36891.650710647344;44202;46534.30198546957;47354.52645473501;48026.27960580524;48444.273335900696;11518.884811152117;11591.6522504325;11655.18413711032;11672.941635291769;11753.177277590486;13213.405396756976;13221.735565288447;13288.601341959757;13477;13590.388432520758;12005.279683219034;12187.329696866758;12284.81572776427;12469.189502682297;12473.5010599575;11736;11894;11951.462184201559;12981.740365192833;13030.218186908816;11394.715132121763;11618.477168527268;11801.350925698825;11854.94072529632;12265.997340624263;9698.854517182106;9852.901470985198;10009.149222316184;10250.436226007641;10306.639267625596;9007.648852672151;9540.427574345562;9808.460534670661;9835.803283934138;9896.356736812084 13:25:46 INFO - PROCESS | 11321 | __end_tp_report 13:25:46 INFO - PROCESS | 11321 | __start_cc_report 13:25:46 INFO - PROCESS | 11321 | _x_x_mozilla_cycle_collect,333 13:25:46 INFO - PROCESS | 11321 | __end_cc_report 13:25:46 INFO - PROCESS | 11321 | __startTimestamp1483824346495__endTimestamp 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | ------- Summary: start ------- 13:25:46 INFO - PROCESS | 11321 | Number of tests: 6 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | [#0] dojo.html Cycles:165 Average:4807.97 Median:4959.36 stddev:537.03 (10.8%) stddev-sans-first:510.12 13:25:46 INFO - PROCESS | 11321 | Values: 2605.3 2618.6 2635.7 2637.2 2655.9 4786.5 4898.9 4907.0 4918.9 4920.8 4841.0 4855.4 4894.3 4906.6 4978.4 4417.9 4460.6 4479.9 4537.8 4580.0 4158.7 4625.6 4652.3 4653.4 4673.3 4445.8 4457.2 4473.6 4522.6 4571.9 4397.1 4407.9 4441.1 4461.2 4525.7 4433.9 4443.8 4454.1 4459.2 4485.3 4777.4 4800.2 4805.1 4823.8 4836.8 5134.5 5203.5 5223.6 5246.7 5275.2 5322.4 5330.0 5333.6 5333.9 5404.7 4959.8 4965.5 4980.9 5001.2 5042.2 5287.6 5288.4 5305.4 5412.2 5431.3 5127.8 5149.7 5177.1 5180.9 5184.2 5226.7 5255.3 5259.2 5274.6 5275.6 5101.8 5139.2 5170.1 5174.7 5193.3 5164.6 5168.0 5168.5 5183.4 5210.9 4222.9 4281.0 4299.4 4303.3 4342.4 3647.2 3663.3 3669.8 3717.2 3731.5 4374.9 4380.1 4384.4 4400.9 4417.2 5126.0 5126.8 5127.2 5140.4 5192.9 4435.6 4439.0 4454.9 4476.2 4481.3 4706.4 4709.8 4709.9 4716.1 4758.1 4876.5 4889.8 4890.8 4892.7 4931.4 5161.8 5207.3 5223.1 5243.3 5264.5 4893.9 4896.2 4902.7 4907.5 4955.1 5095.7 5135.5 5152.0 5215.4 5232.6 5165.5 5261.6 5273.5 5290.0 5300.3 5005.5 5014.3 5018.4 5020.2 5108.4 5052.0 5057.3 5075.7 5105.6 5109.4 4945.3 4947.6 4948.9 4959.4 4991.7 5066.6 5090.5 5102.1 5102.7 5119.4 5022.7 5023.2 5032.7 5034.4 5073.7 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | [#1] ext.html Cycles:180 Average:45502.72 Median:20405.96 stddev:88109.35 (431.8%) stddev-sans-first:88291.72 13:25:46 INFO - PROCESS | 11321 | Values: 495.7 500.9 503.7 509.0 520.7 37274.3 39388.0 39430.2 42664.0 42665.6 40372.4 40841.0 40951.2 41060.4 41142.0 7698.9 7891.3 7891.9 7894.8 7905.8 9271.3 9527.3 9564.8 9786.3 9798.0 9367.2 9421.6 9422.2 9426.3 9434.9 9127.8 9195.2 9197.9 9210.6 9231.2 9610.8 9669.4 9676.8 9678.7 9715.9 34679.8 34738.7 34761.3 34785.8 34791.8 3608.3 3667.8 3678.1 3681.5 3716.5 25722.2 26218.2 26323.0 26419.9 26647.2 3404.6 3408.5 3432.6 3484.4 3496.7 233488.0 236506.0 236898.6 236949.0 236963.8 46773.0 46930.5 46992.5 47053.8 47079.0 48162.0 48182.5 48366.8 48469.5 48497.8 11689.1 12151.8 12162.4 12168.5 12181.3 7831.9 8020.2 8488.2 8497.2 8498.3 15537.8 15990.1 15997.6 16014.1 16143.3 6317.6 6437.3 6447.0 6550.4 6569.4 782.4 785.9 792.7 793.1 809.9 27582.9 28331.0 28346.6 28582.0 28647.8 974.9 976.0 982.0 982.4 1119.0 15128.6 15224.7 15258.7 15284.2 15509.5 367532.0 381710.0 382469.0 556979.0 559549.0 43379.3 43620.6 43644.0 43657.3 43706.8 1233.8 1253.8 1273.2 1274.2 1274.8 25015.9 25775.5 26252.3 26309.6 26568.0 37704.6 38074.8 38125.0 38151.2 38216.8 251199.0 253257.0 254446.0 254516.0 254863.0 23547.5 23948.4 24003.8 24042.3 24368.6 37130.4 37161.4 37867.6 38156.0 38301.6 32321.0 32384.7 32838.0 32980.5 33130.5 31359.0 31879.5 32653.4 32711.0 33177.0 31744.4 31899.7 31999.0 31999.0 32037.8 27978.0 28660.7 29436.1 29669.3 29890.7 22817.3 22835.8 22919.9 22959.4 23145.9 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | [#2] jquery.html Cycles:180 Average:28370.79 Median:22601.77 stddev:81507.98 (360.6%) stddev-sans-first:81709.48 13:25:46 INFO - PROCESS | 11321 | Values: 353.6 366.7 368.4 369.8 387.4 16944.0 18262.6 18761.4 18931.6 18999.2 16504.2 17984.7 18128.5 18211.7 18736.0 5050.9 5212.1 5271.8 5273.4 5284.2 5043.9 5212.5 5235.3 5242.7 5256.7 5187.5 5192.5 5209.4 5214.2 5218.9 5015.5 5143.6 5159.3 5182.9 5196.4 4591.6 4632.7 4646.1 4646.2 4649.5 21793.7 21794.9 21960.8 22030.0 22239.8 2207.2 2249.7 2253.1 2273.1 2329.8 14028.3 14031.0 14236.4 14295.1 14628.2 1702.5 1702.6 1714.9 1734.0 1751.8 78747.0 81094.6 81804.0 84024.0 85149.6 10013.7 10067.2 10342.0 10389.4 10395.4 13906.9 13986.4 14023.2 14302.6 14392.9 6585.6 6763.0 6896.7 6897.6 6929.5 6157.4 6157.5 6206.0 6329.9 6384.0 4254.4 4323.7 4397.4 4515.4 4531.9 1774.9 1819.8 1856.0 1860.9 1873.3 895.3 985.6 990.7 996.5 1014.7 17775.4 18225.3 18387.6 18436.6 18773.5 929.8 940.9 952.3 962.3 971.0 9702.5 9834.0 9990.6 10174.8 10230.6 487267.0 494184.0 494560.0 495144.0 502375.0 69465.7 77912.6 87357.0 87570.6 89055.0 909.2 924.4 946.1 952.9 953.9 14939.6 15371.4 15497.4 15893.4 16172.3 38815.0 39880.2 39892.8 40264.6 40949.2 58231.7 58475.7 59637.7 61286.4 61906.4 7268.8 7450.4 7467.9 7772.9 7889.4 11905.5 12136.6 12269.9 12388.4 12588.3 10039.4 10358.4 10420.9 10503.5 10670.1 10701.7 10703.9 10731.2 10844.9 10975.3 10783.8 10789.9 10803.6 10859.7 11454.5 7658.5 7687.0 7825.4 7927.7 8122.3 7597.8 9589.4 10565.2 10704.3 10933.9 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | [#3] mootools.html Cycles:180 Average:4631.03 Median:5648.49 stddev:2441.25 (43.2%) stddev-sans-first:2435.27 13:25:46 INFO - PROCESS | 11321 | Values: 1300.8 1304.2 1305.7 1317.2 1322.0 6284.2 6375.5 6495.1 6699.9 6725.8 6605.1 6912.9 6927.0 7013.9 7123.6 2079.9 2112.5 2128.7 2131.0 2132.9 2063.4 2076.9 2130.9 2138.7 2170.8 2097.4 2112.9 2114.4 2119.2 2119.7 1978.0 2011.7 2017.6 2020.1 2020.9 2108.3 2116.8 2122.1 2130.2 2132.1 7229.6 7266.9 7307.3 7328.1 7331.0 4312.8 4478.6 4482.6 4484.1 4485.1 2697.1 2806.2 2834.6 2873.6 2888.1 1163.3 1177.2 1634.1 1639.4 1764.9 9218.0 9286.2 9298.1 9299.2 9325.0 3849.9 3857.0 3931.0 3979.1 4042.1 7456.1 7501.0 7529.8 7575.3 7640.4 4335.4 4346.3 4356.2 4366.4 4423.4 3977.4 4073.4 4083.1 4137.2 4153.2 3201.3 3231.2 3247.7 3290.4 3306.3 911.5 922.2 924.5 963.0 981.8 814.2 824.7 838.8 854.6 858.6 4462.2 4481.6 4617.7 4623.2 4708.3 867.4 909.6 920.6 922.2 924.4 3138.6 3142.4 3148.8 3227.7 3260.6 8270.5 8371.0 8499.4 8505.1 8521.1 8310.3 8332.8 8418.1 8426.4 8451.5 6581.0 6624.8 6633.0 6643.4 6730.7 4480.2 4730.0 4840.5 4937.8 4982.1 7653.2 7709.9 7744.2 7759.3 7773.6 7286.6 7551.7 7637.9 7717.7 7833.2 6170.4 6264.9 6292.2 6331.6 6362.7 6735.6 6771.3 6802.6 6836.0 6848.5 5958.9 6034.6 6067.7 6075.9 6186.6 5822.6 5877.6 5905.6 5953.4 6013.0 5598.7 5698.3 5711.5 5720.0 5743.6 3946.9 3959.8 3987.6 4010.1 4081.9 4114.8 4177.0 4217.1 4236.5 4262.9 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | [#4] prototype.html Cycles:180 Average:4236.65 Median:4811.19 stddev:1233.79 (25.6%) stddev-sans-first:1202.08 13:25:46 INFO - PROCESS | 11321 | Values: 339.5 344.9 349.4 352.9 358.9 4925.2 4981.4 5032.3 5064.4 5075.7 4895.9 4938.0 4959.0 4961.8 4982.0 3870.0 3870.3 3879.4 3884.5 3886.2 3773.8 3870.9 3872.0 3872.9 3878.9 3809.8 3828.7 3829.5 3830.3 3835.7 3789.6 3798.2 3809.0 3813.4 3817.8 3332.1 3334.1 3334.5 3336.5 3338.9 4603.0 4814.0 4830.2 4867.8 4872.6 4396.0 4404.9 4407.0 4422.4 4424.5 5220.2 5232.3 5261.3 5265.6 5272.9 3454.0 3653.4 3660.5 3664.1 3667.8 5379.0 5440.0 5443.3 5444.5 5448.0 3696.6 3713.8 3717.4 3722.6 3724.8 3735.4 3739.5 3751.6 3757.0 3785.4 4114.8 4323.7 4343.5 4386.7 4403.9 5249.5 5257.4 5264.9 5265.6 5282.2 1234.5 1263.9 1264.5 1273.5 1282.2 823.8 849.5 854.6 862.5 864.9 4383.4 4389.5 4402.4 4402.8 4406.7 5189.3 5190.8 5202.9 5221.3 5223.3 4384.4 4388.0 4408.4 4411.7 4419.6 2631.3 2752.8 2768.8 2774.3 2782.4 4757.7 4789.7 4797.5 4803.6 4825.5 5127.6 5301.9 5318.6 5319.7 5354.2 4763.0 4781.5 4808.3 4813.5 4829.0 5167.4 5182.7 5192.9 5193.8 5237.9 4998.2 5076.6 5101.0 5135.8 5184.6 4778.1 4804.5 4808.9 4851.5 4855.3 3584.3 3602.9 3603.5 3612.2 3630.7 4860.3 5176.9 5210.9 5211.7 5225.3 4908.2 5009.8 5019.6 5028.7 5048.8 4987.5 5001.9 5006.5 5011.9 5031.8 4851.8 4955.5 4963.8 4967.8 4969.4 5241.1 5259.7 5268.3 5276.2 5283.8 5100.3 5133.2 5139.2 5148.7 5152.7 13:25:46 INFO - PROCESS | 11321 | 13:25:46 INFO - PROCESS | 11321 | [#5] yui.html Cycles:180 Average:15152.67 Median:48235.28 stddev:18930.00 (39.2%) stddev-sans-first:18951.53 13:25:46 INFO - PROCESS | 11321 | Values: 592.9 610.3 713.1 771.9 777.8 11372.8 12144.1 12186.3 12227.3 13926.3 14790.1 15115.5 15876.0 15888.7 15905.0 792.5 815.3 818.2 820.6 823.4 786.5 803.0 809.8 810.0 822.4 853.6 855.3 857.5 858.0 858.4 852.0 853.0 853.0 854.0 854.3 621.8 624.1 624.2 624.2 624.4 13755.8 13762.2 14262.1 14269.2 14389.6 11606.6 12519.7 12572.5 12812.0 12888.9 10832.7 10858.2 10922.2 10946.2 10965.5 3309.8 3318.7 3337.4 3342.1 3352.9 64989.0 65825.7 66812.3 67322.7 67651.7 9200.4 9362.6 9413.5 9414.2 9541.7 16530.2 16827.7 17696.2 18210.6 18337.5 6671.7 6831.3 6881.0 6887.3 7080.8 3608.5 3661.0 3676.2 3707.2 3741.7 2821.3 2866.8 2889.5 2890.8 2893.4 455.8 465.9 469.9 524.2 556.9 589.3 621.6 623.9 629.6 638.2 8707.8 8806.0 9030.6 9042.9 9196.0 583.5 591.7 595.9 599.1 602.9 4308.3 4417.9 4451.8 4468.4 4510.9 66060.0 66210.3 69282.0 69637.7 69733.0 46057.3 58472.7 59352.7 60250.0 60264.0 52043.7 52165.7 52958.0 54491.2 54643.7 8359.2 8613.3 8692.9 8849.3 9664.2 33045.7 34041.0 34919.3 36657.1 36891.7 44202.0 46534.3 47354.5 48026.3 48444.3 11518.9 11591.7 11655.2 11672.9 11753.2 13213.4 13221.7 13288.6 13477.0 13590.4 12005.3 12187.3 12284.8 12469.2 12473.5 11736.0 11894.0 11951.5 12981.7 13030.2 11394.7 11618.5 11801.4 11854.9 12266.0 9698.9 9852.9 10009.1 10250.4 10306.6 9007.6 9540.4 9808.5 9835.8 9896.4 13:25:46 INFO - PROCESS | 11321 | -------- Summary: end -------- 13:25:46 INFO - PROCESS | 11321 | 13:25:47 INFO - TEST-INFO | 11321: exit 0 13:25:47 INFO - TEST-OK | dromaeo_css | took 1119805ms 13:25:47 INFO - TEST-START | kraken 13:25:47 INFO - operating with platform_type : linux_ 13:25:47 INFO - Initialising browser for kraken test... 13:25:47 INFO - TEST-INFO | started process 11679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiNWYju/profile http://localhost:59890/getInfo.html) 13:25:47 INFO - PROCESS | 11679 | 1483824347920 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 13:25:51 INFO - PROCESS | 11679 | __metrics Screen width/height:1600/1200 13:25:51 INFO - PROCESS | 11679 | colorDepth:24 13:25:51 INFO - PROCESS | 11679 | Browser inner width/height: 1024/697 13:25:51 INFO - PROCESS | 11679 | __metrics 13:25:52 ERROR - PROCESS | 11679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 13:25:53 INFO - TEST-INFO | 11679: exit 0 13:25:53 INFO - Browser initialized. 13:25:53 INFO - Running cycle 1/1 for kraken test... 13:25:53 INFO - TEST-INFO | started process 11803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiNWYju/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:05 INFO - PROCESS | 11803 | RSS: Main: 158965760 13:26:05 INFO - PROCESS | 11803 | 13:26:08 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59890/tests/kraken/driver.html?testName=audio-beat-detection) 13:26:09 INFO - PROCESS | 11803 | RSS: Main: 164839424 13:26:09 INFO - PROCESS | 11803 | 13:26:11 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59890/tests/kraken/driver.html?testName=audio-dft) 13:26:12 INFO - PROCESS | 11803 | RSS: Main: 163807232 13:26:12 INFO - PROCESS | 11803 | 13:26:15 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59890/tests/kraken/driver.html?testName=audio-fft) 13:26:16 INFO - PROCESS | 11803 | RSS: Main: 160292864 13:26:16 INFO - PROCESS | 11803 | 13:26:18 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59890/tests/kraken/driver.html?testName=audio-oscillator) 13:26:18 INFO - PROCESS | 11803 | RSS: Main: 161239040 13:26:18 INFO - PROCESS | 11803 | 13:26:21 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59890/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:26:21 INFO - PROCESS | 11803 | RSS: Main: 161509376 13:26:21 INFO - PROCESS | 11803 | 13:26:24 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59890/tests/kraken/driver.html?testName=imaging-darkroom) 13:26:25 INFO - PROCESS | 11803 | RSS: Main: 167100416 13:26:25 INFO - PROCESS | 11803 | 13:26:28 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59890/tests/kraken/driver.html?testName=imaging-desaturate) 13:26:29 INFO - PROCESS | 11803 | RSS: Main: 162742272 13:26:29 INFO - PROCESS | 11803 | 13:26:32 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59890/tests/kraken/driver.html?testName=json-parse-financial) 13:26:33 INFO - PROCESS | 11803 | RSS: Main: 164179968 13:26:33 INFO - PROCESS | 11803 | 13:26:34 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59890/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:26:35 INFO - PROCESS | 11803 | RSS: Main: 164888576 13:26:35 INFO - PROCESS | 11803 | 13:26:37 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:26:38 INFO - PROCESS | 11803 | RSS: Main: 163983360 13:26:38 INFO - PROCESS | 11803 | 13:26:40 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:26:40 INFO - PROCESS | 11803 | RSS: Main: 164376576 13:26:40 INFO - PROCESS | 11803 | 13:26:43 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:26:44 INFO - PROCESS | 11803 | RSS: Main: 164511744 13:26:44 INFO - PROCESS | 11803 | 13:26:47 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:26:48 INFO - PROCESS | 11803 | RSS: Main: 164339712 13:26:48 INFO - PROCESS | 11803 | 13:26:49 INFO - PROCESS | 11803 | Cycle 1(1): loaded http://localhost:59890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59890/tests/kraken/driver.html?testName=ai-astar) 13:26:50 INFO - PROCESS | 11803 | RSS: Main: 166051840 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | __start_tp_report 13:26:50 INFO - PROCESS | 11803 | _x_x_mozilla_page_load 13:26:50 INFO - PROCESS | 11803 | _x_x_mozilla_page_load_details 13:26:50 INFO - PROCESS | 11803 | |i|pagename|runs| 13:26:50 INFO - PROCESS | 11803 | |0;ai-astar;106;115;115;114;115;115;114;115;114;114 13:26:50 INFO - PROCESS | 11803 | |1;audio-beat-detection;156;126;125;169;130;124;133;134;151;127 13:26:50 INFO - PROCESS | 11803 | |2;audio-dft;166;165;165;178;165;163;165;164;164;164 13:26:50 INFO - PROCESS | 11803 | |3;audio-fft;78;76;76;112;79;77;77;79;101;76 13:26:50 INFO - PROCESS | 11803 | |4;audio-oscillator;85;85;105;86;86;85;98;85;84;110 13:26:50 INFO - PROCESS | 11803 | |5;imaging-gaussian-blur;118;119;118;118;118;119;120;128;118;118 13:26:50 INFO - PROCESS | 11803 | |6;imaging-darkroom;150;151;151;150;150;151;150;150;151;149 13:26:50 INFO - PROCESS | 11803 | |7;imaging-desaturate;96;95;96;96;96;96;96;97;96;96 13:26:50 INFO - PROCESS | 11803 | |8;json-parse-financial;63;66;63;64;66;65;68;66;66;66 13:26:50 INFO - PROCESS | 11803 | |9;json-stringify-tinderbox;69;68;68;68;68;69;69;67;68;68 13:26:50 INFO - PROCESS | 11803 | |10;stanford-crypto-aes;88;86;91;91;86;87;85;85;86;86 13:26:50 INFO - PROCESS | 11803 | |11;stanford-crypto-ccm;141;134;134;134;136;134;134;136;181;139 13:26:50 INFO - PROCESS | 11803 | |12;stanford-crypto-pbkdf2;185;182;188;182;186;185;181;180;184;182 13:26:50 INFO - PROCESS | 11803 | |13;stanford-crypto-sha256-iterative;71;75;70;71;70;68;70;69;69;69 13:26:50 INFO - PROCESS | 11803 | __end_tp_report 13:26:50 INFO - PROCESS | 11803 | __start_cc_report 13:26:50 INFO - PROCESS | 11803 | _x_x_mozilla_cycle_collect,797 13:26:50 INFO - PROCESS | 11803 | __end_cc_report 13:26:50 INFO - PROCESS | 11803 | __startTimestamp1483824410201__endTimestamp 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | ------- Summary: start ------- 13:26:50 INFO - PROCESS | 11803 | Number of tests: 14 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:2.75 (2.4%) stddev-sans-first:0.53 13:26:50 INFO - PROCESS | 11803 | Values: 106.0 115.0 115.0 114.0 115.0 115.0 114.0 115.0 114.0 114.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:133.50 stddev:15.59 (11.7%) stddev-sans-first:15.03 13:26:50 INFO - PROCESS | 11803 | Values: 156.0 126.0 125.0 169.0 130.0 124.0 133.0 134.0 151.0 127.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:4.33 (2.6%) stddev-sans-first:4.59 13:26:50 INFO - PROCESS | 11803 | Values: 166.0 165.0 165.0 178.0 165.0 163.0 165.0 164.0 164.0 164.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#3] audio-fft Cycles:10 Average:83.10 Median:77.00 stddev:12.65 (16.4%) stddev-sans-first:13.29 13:26:50 INFO - PROCESS | 11803 | Values: 78.0 76.0 76.0 112.0 79.0 77.0 77.0 79.0 101.0 76.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:85.00 stddev:9.71 (11.4%) stddev-sans-first:10.06 13:26:50 INFO - PROCESS | 11803 | Values: 85.0 85.0 105.0 86.0 86.0 85.0 98.0 85.0 84.0 110.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#5] imaging-gaussian-blur Cycles:10 Average:119.40 Median:118.50 stddev:3.10 (2.6%) stddev-sans-first:3.24 13:26:50 INFO - PROCESS | 11803 | Values: 118.0 119.0 118.0 118.0 118.0 119.0 120.0 128.0 118.0 118.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 13:26:50 INFO - PROCESS | 11803 | Values: 150.0 151.0 151.0 150.0 150.0 151.0 150.0 150.0 151.0 149.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:26:50 INFO - PROCESS | 11803 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:66.00 stddev:1.57 (2.4%) stddev-sans-first:1.42 13:26:50 INFO - PROCESS | 11803 | Values: 63.0 66.0 63.0 64.0 66.0 65.0 68.0 66.0 66.0 66.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 13:26:50 INFO - PROCESS | 11803 | Values: 69.0 68.0 68.0 68.0 68.0 69.0 69.0 67.0 68.0 68.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:2.23 (2.6%) stddev-sans-first:2.35 13:26:50 INFO - PROCESS | 11803 | Values: 88.0 86.0 91.0 91.0 86.0 87.0 85.0 85.0 86.0 86.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:136.00 stddev:14.51 (10.7%) stddev-sans-first:15.38 13:26:50 INFO - PROCESS | 11803 | Values: 141.0 134.0 134.0 134.0 136.0 134.0 134.0 136.0 181.0 139.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:184.50 stddev:2.51 (1.4%) stddev-sans-first:2.60 13:26:50 INFO - PROCESS | 11803 | Values: 185.0 182.0 188.0 182.0 186.0 185.0 181.0 180.0 184.0 182.0 13:26:50 INFO - PROCESS | 11803 | 13:26:50 INFO - PROCESS | 11803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.93 (2.8%) stddev-sans-first:2.03 13:26:50 INFO - PROCESS | 11803 | Values: 71.0 75.0 70.0 71.0 70.0 68.0 70.0 69.0 69.0 69.0 13:26:50 INFO - PROCESS | 11803 | -------- Summary: end -------- 13:26:50 INFO - PROCESS | 11803 | 13:26:51 INFO - TEST-INFO | 11803: exit 0 13:26:51 INFO - TEST-OK | kraken | took 63968ms 13:26:51 INFO - SUITE-END | took 1183s 13:26:51 INFO - Completed test suite (00:19:44) 13:26:51 INFO - javascript benchmark 13:26:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6352.1346281287315, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.283547024568, 2618.581027035674, 2635.7364263573645, 2637.222019504246, 2655.94688106238, 4786.540105267892, 4898.926516102261, 4907.043126590316, 4918.8770280743, 4920.778564964577, 4841.0, 4855.441624213207, 4894.314795928564, 4906.63200259981, 4978.402591689002, 4417.889552761175, 4460.643148548108, 4479.910401791963, 4537.795799189028, 4580.015296711206, 4158.688098392618, 4625.5836974672275, 4652.302154676791, 4653.441587009564, 4673.3223682566, 4445.755483448409, 4457.2199865023495, 4473.552644735533, 4522.570355816192, 4571.862844114682, 4397.120575884804, 4407.933880991788, 4441.111777644484, 4461.196984542781, 4525.683202175849, 4433.933490997605, 4443.844465443726, 4454.13144436835, 4459.152760975437, 4485.349624304457, 4777.378940737716, 4800.183968725325, 4805.063012712522, 4823.758812059383, 4836.806527738886, 5134.460881607452, 5203.505666961671, 5223.608229382811, 5246.685198888041, 5275.155975044013, 5322.361316641989, 5330.040592693314, 5333.57331413486, 5333.946660533384, 5404.729763511808, 4959.776810043557, 4965.478624744422, 4980.850574482772, 5001.24981252815, 5042.193249080166, 5287.603429742785, 5288.418273989858, 5305.389880163753, 5412.242286079952, 5431.266778984866, 5127.769250383742, 5149.6910185389, 5177.145770947826, 5180.922286165711, 5184.248283998874, 5226.738663066832, 5255.290535777697, 5259.15853463444, 5274.5780337572905, 5275.60432967529, 5101.770420331094, 5139.203423469368, 5170.069387510209, 5174.689518628894, 5193.272941788153, 5164.586833053347, 5167.974160129175, 5168.53483186515, 5183.403908550489, 5210.947890521122, 4222.936655950163, 4280.978595107067, 4299.441072660534, 4303.291953610868, 4342.413774140514, 3647.179384638488, 3663.2673465307043, 3669.798161101165, 3717.20080182762, 3731.477593136963, 4374.890627734332, 4380.080183161508, 4384.4300240969105, 4400.9119817604105, 4417.2269852775635, 5125.974805038933, 5126.846194614168, 5127.2052831811125, 5140.3831540215415, 5192.870178245498, 4435.6229720473475, 4439.045605194834, 4454.910901781946, 4476.239039363316, 4481.260592002283, 4706.411698537683, 4709.81160753566, 4709.858704238878, 4716.127516409407, 4758.07217592573, 4876.536729010738, 4889.804407823647, 4890.828820991248, 4892.657513973988, 4931.4328852181025, 5161.819336323361, 5207.270982062439, 5223.138182200047, 5243.292155558951, 5264.499872512105, 4893.853184404474, 4896.216605343128, 4902.656814023127, 4907.460179380337, 4955.083309587738, 5095.668781529189, 5135.537801597874, 5152.0, 5215.374155101412, 5232.555232805102, 5165.535101840853, 5261.631685781958, 5273.499017593323, 5290.047791397586, 5300.284461597789, 5005.499450054966, 5014.34813474246, 5018.422881368543, 5020.221865610836, 5108.412532558803, 5051.974740126423, 5057.31726216956, 5075.670081444694, 5105.591552675852, 5109.386873575195, 4945.2582112683385, 4947.579455746302, 4948.851534453972, 4959.355283813081, 4991.700497970133, 5066.645334826527, 5090.516400941905, 5102.10713125209, 5102.727268197105, 5119.360079990001, 5022.698638081727, 5023.2214006829, 5032.672876263177, 5034.421041580119, 5073.6702114363925], "value": 4771.041358525746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.6976244490861, 500.9398872135344, 503.71791796593885, 508.9770960306786, 520.6927912531605, 37274.25451490972, 39388.0, 39430.2113957721, 42664.0, 42665.57334426655, 40372.39441408374, 40841.0, 40951.180976380456, 41060.38409423861, 41142.0, 7698.923010769877, 7891.289783919446, 7891.881621775678, 7894.842103157934, 7905.841883162362, 9271.25829933607, 9527.285453590974, 9564.808703825955, 9786.26603004774, 9797.951010244975, 9367.203787678056, 9421.576029078708, 9422.199113075363, 9426.34015618907, 9434.858477122849, 9127.817443651124, 9195.172434480863, 9197.908020919805, 9210.585523651385, 9231.169194772503, 9610.807783844353, 9669.371490853073, 9676.75808104796, 9678.661246856396, 9715.90284097157, 34679.82660086708, 34738.65261347405, 34761.30477390463, 34785.82607086949, 34791.82604086964, 3608.260306637133, 3667.7982710950887, 3678.08047988003, 3681.4845921571, 3716.4982727331735, 25722.228333150037, 26218.21345359642, 26323.0, 26419.867900660374, 26647.20058398251, 3404.557407537029, 3408.454647256452, 3432.5709286339206, 3484.372812893678, 3496.720262379029, 233488.0, 236506.0, 236898.5721713388, 236949.0, 236963.81518092472, 46773.0, 46930.5306946933, 46992.5300746995, 47053.764731176125, 47079.0, 48162.0, 48182.518174818506, 48366.75816620965, 48469.515304847206, 48497.75751121222, 11689.123315751183, 12151.756964860653, 12162.391880406121, 12168.45241964096, 12181.33002684861, 7831.882521762178, 8020.157883422274, 8488.236058754741, 8497.150284971452, 8498.277646400125, 15537.766933496006, 15990.120543369994, 15997.60005999836, 16014.119223442822, 16143.273552689921, 6317.557770955989, 6437.2918978912285, 6446.967765161145, 6550.3972814951585, 6569.37590928861, 782.4366456151562, 785.8664027115404, 792.6551949901811, 793.0562630469723, 809.8501777171242, 27582.862085689845, 28331.0, 28346.574801377996, 28582.0, 28647.775045609647, 974.8878878928872, 975.9853602195973, 981.9607215711435, 982.3712823792779, 1118.959367787965, 15128.621784455256, 15224.695506090038, 15258.694826103416, 15284.159371234466, 15509.5347139586, 367532.0, 381710.0, 382469.0, 556979.0, 559549.0, 43379.34930976038, 43620.56379436165, 43643.99999999937, 43657.34513982293, 43706.78146609246, 1233.8457692788402, 1253.8088815625192, 1273.1533530202496, 1274.1908887856277, 1274.7577960187534, 25015.874920626007, 25775.484490309715, 26252.343691407103, 26309.605355919295, 26568.0, 37704.622953771206, 38074.80962595169, 38125.0, 38151.23697525978, 38216.80891595524, 251199.0, 253257.0, 254446.0, 254516.0, 254863.0, 23547.52904941926, 23948.365679774863, 24003.759962400152, 24042.278731638078, 24368.6344704826, 37130.44304335383, 37161.4425783608, 37867.62132378641, 38156.0, 38301.61698382981, 32321.0, 32384.67615323911, 32838.0, 32980.50529242015, 33130.5030424539, 31359.0, 31879.521807173376, 32653.428520006742, 32711.0, 33177.0, 31744.433031841825, 31899.68100318967, 31999.0, 31999.0, 32037.839810800797, 27978.0, 28660.713392866637, 29436.116916492538, 29669.25826854346, 29890.72753636225, 22817.31548053561, 22835.771642284028, 22919.885400573556, 22959.42601434911, 23145.88427057854], "value": 16860.656805922536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.6163262859797, 366.73961487343985, 368.43445311446936, 369.81658692185005, 387.3666555182276, 16943.999999999985, 18262.634747305063, 18761.437156885317, 18931.62136757264, 18999.240030398767, 16504.174791260448, 17984.73022904654, 18128.54678633035, 18211.72682409765, 18736.0, 5050.888804463012, 5212.113940630083, 5271.813841885583, 5273.446288139748, 5284.180951952434, 5043.949560504403, 5212.478752124795, 5235.345581802275, 5242.711650859202, 5256.737163141827, 5187.455317191697, 5192.506711862386, 5209.374875014984, 5214.191800270964, 5218.921716174261, 5015.473375295596, 5143.614228932807, 5159.251908473269, 5182.922256166161, 5196.376434827807, 4591.586757191869, 4632.745199014053, 4646.094011667727, 4646.186917289461, 4649.5350464953235, 21793.67309490359, 21794.89102554477, 21960.780392196033, 22030.0, 22239.777602223934, 2207.249535158054, 2249.718785151856, 2253.0649780341137, 2273.056681477185, 2329.77867102625, 14028.298585070706, 14031.0, 14236.359363828653, 14295.142291462545, 14628.195449250286, 1702.5232934778282, 1702.5658457093487, 1714.8542373898233, 1733.9913300433543, 1751.842334189929, 78747.0, 81094.59452702758, 81804.0, 84024.0, 85149.57425212896, 10013.749656258651, 10067.194624430029, 10342.0, 10389.428581428094, 10395.428251446092, 13906.860931390556, 13986.440542378394, 14023.158610483404, 14302.57092287233, 14392.856071439151, 6585.6377899216, 6762.966185169141, 6896.724131034703, 6897.62063086525, 6929.480288978347, 6157.384261573807, 6157.538184636171, 6205.968970155121, 6329.875948642581, 6383.968080159662, 4254.361845723104, 4323.675724320626, 4397.428334316518, 4515.390422293014, 4531.909361812811, 1774.9023803690663, 1819.7543331650058, 1855.9721604175948, 1860.8976506292013, 1873.3443294846695, 895.2927187521915, 985.556499575194, 990.7269159130627, 996.5067291690659, 1014.7260239735377, 17775.444911017847, 18225.270989160286, 18387.632247354977, 18436.631267374847, 18773.530661733294, 929.809389075238, 940.9294302927308, 952.2667545989688, 962.3071388600197, 970.9611615535299, 9702.5148742564, 9833.950830245803, 9990.600375984879, 10174.847377289347, 10230.64192753265, 487267.0, 494184.0, 494560.0, 495144.0, 502375.0, 69465.65267173733, 77912.61043694745, 87357.0, 87570.56214718886, 89055.0, 909.1908201700492, 924.4037595750704, 946.0586716217408, 952.8618350339301, 953.8759961204998, 14939.626509337353, 15371.385144594538, 15497.380104795682, 15893.443729469413, 16172.272247749115, 38815.0, 39880.20239595134, 39892.800535997136, 40264.59735402608, 40949.1810163801, 58231.70884145552, 58475.70762146332, 59637.70181149067, 61286.38713612807, 61906.380936190064, 7268.818279543054, 7450.403967682681, 7467.850642987001, 7772.922270777446, 7889.3826765511785, 11905.523779049088, 12136.575219867262, 12269.93865030669, 12388.380580971096, 12588.30764307972, 10039.397636141855, 10358.399427514914, 10420.947895260475, 10503.527341269508, 10670.146388289073, 10701.678949631523, 10703.892961070289, 10731.248812583044, 10844.891551084389, 10975.28660637056, 10783.838242426527, 10789.946050269698, 10803.621873234399, 10859.674209773719, 11454.541818327174, 7658.502197357154, 7686.961565192362, 7825.413094018085, 7927.682892684228, 8122.309603683517, 7597.772066838003, 9589.42463452195, 10565.154787617126, 10704.250702451065, 10933.890661093288], "value": 8599.420196310422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.7918733002716, 1304.2174695182885, 1305.699689071513, 1317.2030921292617, 1321.9801702974455, 6284.214473190851, 6375.458086062685, 6495.058216558608, 6699.899501507482, 6725.831854203641, 6605.141331626882, 6912.896306555405, 6927.0, 7013.894791578117, 7123.643817809115, 2079.9480012999684, 2112.4613223627953, 2128.723265975421, 2130.957380852382, 2132.8826914519695, 2063.38098570429, 2076.9376918692465, 2130.925417610384, 2138.6685063815135, 2170.8263338932925, 2097.4127244371603, 2112.9154833806706, 2114.37625900359, 2119.152339064371, 2119.6926445665367, 1977.9505512362307, 2011.6580181369202, 2017.6065667194903, 2020.070767446976, 2020.9393718188478, 2108.2515706924128, 2116.8412369072225, 2122.1193204819983, 2130.20117455954, 2132.051237199447, 7229.638518074128, 7266.854662906712, 7307.269273072703, 7328.083989501312, 7330.963345183293, 4312.805923733439, 4478.552144785528, 4482.618977386926, 4484.148011877733, 4485.0805584855025, 2697.082991782803, 2806.1581525542256, 2834.5606431003225, 2873.5833304170988, 2888.140740666746, 1163.3194581170026, 1177.170095082973, 1634.1094103713506, 1639.385230538548, 1764.938227162056, 9218.0, 9286.164245217895, 9298.070192980715, 9299.209567186797, 9325.0, 3849.9230015400094, 3857.035741064734, 3931.0, 3979.064919743858, 4042.0501182222156, 7456.105267367951, 7500.962495187489, 7529.849403012018, 7575.318221359994, 7640.3505702015955, 4335.393044973706, 4346.304591265382, 4356.150550642595, 4366.388705581221, 4423.424954755926, 3977.443157957888, 4073.3889916512762, 4083.060895993938, 4137.234611596864, 4153.231652144363, 3201.2797120648133, 3231.2245061185145, 3247.7077063063966, 3290.3583801159025, 3306.2891478331794, 911.4850109688005, 922.2299380017761, 924.523870206844, 962.9711108666751, 981.7545613596601, 814.1614137438448, 824.7072289337319, 838.7892778253135, 854.5812551849549, 858.587877818638, 4462.174497717932, 4481.551844815493, 4617.699849509771, 4623.237165867661, 4708.340832283483, 867.3581549653211, 909.6315992023241, 920.6317473010715, 922.2017066719923, 924.4360939826701, 3138.5919830422354, 3142.3872344892984, 3148.795328303653, 3227.661095584977, 3260.55982442372, 8270.545120018336, 8370.958145209235, 8499.40504164715, 8505.064442911274, 8521.10528394522, 8310.252077313071, 8332.750017499484, 8418.074011858691, 8426.41015128935, 8451.45065570736, 6581.0, 6624.8012559623285, 6632.966835165793, 6643.40209381158, 6730.663466826639, 4480.171168333869, 4729.976350118227, 4840.515948405131, 4937.777799998937, 4982.053409852117, 7653.158152603098, 7709.8843517348405, 7744.186860379805, 7759.262870027338, 7773.572453515111, 7286.599237042014, 7551.73568925085, 7637.88543171864, 7717.729879454417, 7833.216678332121, 6170.382961703794, 6264.937350626436, 6292.2134733158355, 6331.556791024584, 6362.713677884413, 6735.62954037513, 6771.255161932282, 6802.591844489347, 6836.008778726958, 6848.520603557703, 5958.940410595838, 6034.607750496204, 6067.696615169312, 6075.939240607538, 6186.597871138361, 5822.5633077518505, 5877.588568800143, 5905.616134951214, 5953.434423729739, 6012.969935150296, 5598.692071936082, 5698.287714035746, 5711.457411545896, 5720.027595308724, 5743.59794814359, 3946.881593552198, 3959.8020098994357, 3987.6211759882763, 4010.1177740896956, 4081.8979525510913, 4114.7942602870335, 4177.0, 4217.135487225173, 4236.5339812621205, 4262.87211383659], "value": 3835.865382174057, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.5365326329561, 344.91867993839315, 349.43566140682805, 352.90118766745314, 358.92642008388265, 4925.1627223372025, 4981.352424184855, 5032.270320803481, 5064.417591976924, 5075.695458272502, 4895.926561101577, 4938.0, 4958.975205123978, 4961.776720047597, 4981.975090124544, 3869.9806500967456, 3870.342041852885, 3879.3792993121106, 3884.514435695538, 3886.24218277436, 3773.7735735855936, 3870.9419358709642, 3871.9806400967955, 3872.8838134856, 3878.9030274243228, 3809.7904615246152, 3828.693704503647, 3829.5213098362706, 3830.3105441020607, 3835.654791068803, 3789.5831458539537, 3798.2403519295976, 3808.9809550952345, 3813.40892161714, 3817.8091095445116, 3332.133645252228, 3334.1331253873923, 3334.483155110962, 3336.5328853960223, 3338.916527086818, 4602.953970460286, 4813.951860481386, 4830.178869592178, 4867.78094985723, 4872.634552408584, 4395.978020109911, 4404.911901761947, 4406.955930440687, 4422.358757980107, 4424.513303536608, 5220.207189153823, 5232.29950266165, 5261.263423120766, 5265.578753699695, 5272.947270527284, 3454.0, 3653.3971894637352, 3660.4509323601405, 3664.1022949377575, 3667.826295585414, 5378.973105134489, 5440.0, 5443.305563745931, 5444.537214336826, 5447.972760136214, 3696.611855755161, 3713.7586056906216, 3717.423799311111, 3722.6091260417807, 3724.8137593120236, 3735.402335626287, 3739.476473293741, 3751.606081361472, 3757.0, 3785.356489396754, 4114.835406583703, 4323.670773504384, 4343.522212556616, 4386.736795792199, 4403.933940990888, 5249.527542521191, 5257.369115706139, 5264.894702106013, 5265.6050796189675, 5282.234076059027, 1234.469258119925, 1263.9304838233802, 1264.5141958199263, 1273.4969686973593, 1282.2434763489587, 823.838387873096, 849.4521033933202, 854.6154230596256, 862.4652715316544, 864.9361285618725, 4383.364412160219, 4389.495208051051, 4402.427684401007, 4402.779861006937, 4406.691531592822, 5189.273501709764, 5190.8183213587345, 5202.92195617066, 5221.269022336875, 5223.347081614798, 4384.4300240969105, 4388.0, 4408.426904502394, 4411.713238639478, 4419.64642828573, 2631.2632462910415, 2752.843805601652, 2768.820026698258, 2774.320291528548, 2782.3739658577065, 4757.690750101232, 4789.688670236424, 4797.488791030814, 4803.639727020487, 4825.469198388175, 5127.564157046618, 5301.879248300711, 5318.574514038867, 5319.6808191508635, 5354.223637572608, 4762.976185119052, 4781.545753153376, 4808.2547205183255, 4813.518648135158, 4829.0, 5167.431582525995, 5182.714950677749, 5192.870178245423, 5193.818596189685, 5237.895242095061, 4998.225275082368, 5076.6446348755235, 5101.0308041472, 5135.818761684759, 5184.6409883502165, 4778.064883722098, 4804.543568361, 4808.869915569909, 4851.549967266508, 4855.295982082649, 3584.336897673939, 3602.8919132426067, 3603.4955106284615, 3612.2414292998765, 3630.6929505377516, 4860.3195552621955, 5176.948230517647, 5210.947890521046, 5211.6710238888845, 5225.346831646044, 4908.171626131623, 5009.849704508871, 5019.598432125348, 5028.698278103326, 5048.823291184791, 4987.476314986874, 5001.899962000667, 5006.499350064964, 5011.924821127613, 5031.798728050837, 4851.805927762991, 4955.479674634255, 4963.801447942042, 4967.776450059829, 4969.378827646544, 5241.135212689864, 5259.684418934723, 5268.2624432578705, 5276.2349459327415, 5283.815066472809, 5100.26046223303, 5133.178691409356, 5139.177731562932, 5148.665336753099, 5152.690838549699], "value": 3854.8969924900225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.8962431574479, 610.282917571853, 713.1477883928704, 771.8649236383632, 777.7783331750452, 11372.829407558884, 12144.149909506337, 12186.268823870563, 12227.327496987662, 13926.30368481577, 14790.112593244412, 15115.546533603982, 15876.0, 15888.682226355466, 15905.0, 792.5284455748834, 815.2621877201112, 818.2267756969666, 820.6143112737004, 823.4030328012203, 786.5477350523472, 803.0323460230409, 809.8056466448039, 810.0401024785648, 822.4489591973362, 853.6244052616829, 855.2943821347413, 857.4640849469082, 858.047567200407, 858.3776761847673, 852.0201767966826, 853.0, 853.036069241759, 853.9914600853974, 854.2695994924312, 621.8134559632138, 624.1168746224088, 624.2103738770459, 624.2477814233882, 624.3631495874229, 13755.79366309506, 13762.174269543859, 14262.144271343752, 14269.215193164371, 14389.568312950629, 11606.593769218121, 12519.687007824787, 12572.497100115985, 12812.0, 12888.871111288861, 10832.72918177044, 10858.185636077247, 10922.1808364373, 10946.17903657221, 10965.50655220517, 3309.834508274577, 3318.734501239895, 3337.365900478901, 3342.097633638928, 3352.865885364607, 64989.0, 65825.67087164581, 66812.33187668158, 67322.66338668275, 67651.66174169097, 9200.35597508168, 9362.578683959238, 9413.48225847585, 9414.246860251164, 9541.666041688508, 16530.173491325626, 16827.74758378625, 17696.203670834584, 18210.63578728418, 18337.541561460803, 6671.733130674816, 6831.316868313129, 6880.965595171992, 6887.345702158287, 7080.822979425452, 3608.548931383577, 3661.0, 3676.1544844685873, 3707.2029513654693, 3741.7380783344906, 2821.2523681224493, 2866.756325712338, 2889.4943384907556, 2890.8410037448143, 2893.363460038788, 455.76072561905266, 465.8765427161805, 469.9318598803154, 524.1665751455205, 556.9387367389584, 589.3311091910626, 621.6456619726713, 623.9032949892774, 629.5907660021023, 638.2118084166051, 8707.782305442288, 8805.955970220237, 9030.593623286968, 9042.909570904338, 9196.022315787312, 583.4952765857503, 591.6598903483613, 595.85401576614, 599.12228585123, 602.9306629737637, 4308.267594508941, 4417.867463976086, 4451.755153466525, 4468.352088947149, 4510.909781804411, 66060.0, 66210.33789662042, 69282.0, 69637.65181174062, 69733.0, 46057.30914036292, 58472.70763646239, 59352.70323648354, 60250.0, 60264.0, 52043.73978130085, 52165.7391713039, 52958.0, 54491.18263226055, 54643.72678136663, 8359.247667709935, 8613.31093512505, 8692.913070869463, 8849.292056635324, 9664.178544823488, 33045.66954330426, 34041.0, 34919.301613968084, 36657.08357291089, 36891.650710647344, 44202.0, 46534.30198546957, 47354.52645473501, 48026.27960580524, 48444.273335900696, 11518.884811152117, 11591.6522504325, 11655.18413711032, 11672.941635291769, 11753.177277590486, 13213.405396756976, 13221.735565288447, 13288.601341959757, 13477.0, 13590.388432520758, 12005.279683219034, 12187.329696866758, 12284.81572776427, 12469.189502682297, 12473.5010599575, 11736.0, 11894.0, 11951.462184201559, 12981.740365192833, 13030.218186908816, 11394.715132121763, 11618.477168527268, 11801.350925698825, 11854.94072529632, 12265.997340624263, 9698.854517182106, 9852.901470985198, 10009.149222316184, 10250.436226007641, 10306.639267625596, 9007.648852672151, 9540.427574345562, 9808.460534670661, 9835.803283934138, 9896.356736812084], "value": 6421.472455398694, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 125.0, 169.0, 130.0, 124.0, 133.0, 134.0, 151.0, 127.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 165.0, 178.0, 165.0, 163.0, 165.0, 164.0, 164.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 112.0, 79.0, 77.0, 77.0, 79.0, 101.0, 76.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 86.0, 86.0, 85.0, 98.0, 85.0, 84.0, 110.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 119.0, 120.0, 128.0, 118.0, 118.0], "value": 119.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 150.0, 150.0, 151.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 64.0, 66.0, 65.0, 68.0, 66.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 67.0, 68.0, 68.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 91.0, 91.0, 86.0, 87.0, 85.0, 85.0, 86.0, 86.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 134.0, 134.0, 134.0, 136.0, 134.0, 134.0, 136.0, 181.0, 139.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 188.0, 182.0, 186.0, 185.0, 181.0, 180.0, 184.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 70.0, 71.0, 70.0, 68.0, 70.0, 69.0, 69.0, 69.0], "value": 70.2, "unit": "score"}]}]} 13:26:51 INFO - Return code: 0 13:26:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:26:51 ERROR - # TBPL SUCCESS # 13:26:51 INFO - Running post-action listener: _resource_record_post_action 13:26:51 INFO - [mozharness: 2017-01-07 21:26:51.997825Z] Finished run-tests step (success) 13:26:51 INFO - Running post-run listener: _resource_record_post_run 13:26:52 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 4096; Write bytes: 411758592; Read time: 8; Write time: 377300 13:26:52 INFO - TinderboxPrint: CPU usage
13.5% 13:26:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:26:52 INFO - TinderboxPrint: I/O write bytes / time
411,758,592 / 377,300 13:26:52 INFO - TinderboxPrint: CPU idle
8,283.8 (86.4%) 13:26:52 INFO - TinderboxPrint: CPU user
1,235.2 (12.9%) 13:26:52 INFO - TinderboxPrint: Swap in / out
0 / 0 13:26:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 100184064; Read time: 0; Write time: 151796 13:26:52 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 294793216; Read time: 0; Write time: 216176 13:26:52 INFO - Running post-run listener: _upload_blobber_files 13:26:52 INFO - Blob upload gear active. 13:26:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:26:52 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 13:26:52 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:26:52 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:26:53 INFO - (blobuploader) - INFO - Open directory for files ... 13:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:56 INFO - (blobuploader) - INFO - Done attempting. 13:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:57 INFO - (blobuploader) - INFO - Done attempting. 13:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:58 INFO - (blobuploader) - INFO - Done attempting. 13:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:26:58 INFO - (blobuploader) - INFO - Done attempting. 13:26:58 INFO - (blobuploader) - INFO - Iteration through files over. 13:26:58 INFO - Return code: 0 13:26:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:26:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:26:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62fb7f1a48cb731fdb1d80d0b773db0a807d3905e59395f9193db1dc838978b8fd2882bf8a93d37ab5f1372c0973b7ea3599bd45bf5cdc062293bfb68ae8c38c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e9af4a042534e16637f54d2d268c1a5b16a670b97c260c151b44e1e8aaf0ac2f751d5d41b0105f226cdb31096e3e162649d04076e5de0cc72d973a61a7f326c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b169f06e788419126e618ae49e8add4664af2dd3f8a2748b0b5528448c002f5017870db1d362f297a6945c7d51c964af5e8029db149217bd83bf34e77efb72db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c953331d1d6a82e61fb2ca0f4e40372b723dea0a017f3c745d09e0345341b543a8f8ec7ab04fdd211f79158556bc43cd40d677f9e615140832e120eb6773817c"} 13:26:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:26:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:26:58 INFO - Contents: 13:26:58 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62fb7f1a48cb731fdb1d80d0b773db0a807d3905e59395f9193db1dc838978b8fd2882bf8a93d37ab5f1372c0973b7ea3599bd45bf5cdc062293bfb68ae8c38c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e9af4a042534e16637f54d2d268c1a5b16a670b97c260c151b44e1e8aaf0ac2f751d5d41b0105f226cdb31096e3e162649d04076e5de0cc72d973a61a7f326c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b169f06e788419126e618ae49e8add4664af2dd3f8a2748b0b5528448c002f5017870db1d362f297a6945c7d51c964af5e8029db149217bd83bf34e77efb72db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c953331d1d6a82e61fb2ca0f4e40372b723dea0a017f3c745d09e0345341b543a8f8ec7ab04fdd211f79158556bc43cd40d677f9e615140832e120eb6773817c"} 13:26:58 INFO - Running post-run listener: copy_logs_to_upload_dir 13:26:58 INFO - Copying logs to upload dir... 13:26:58 INFO - mkdir: /builds/slave/test/build/upload/logs 13:26:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.255812 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-07 13:26:59.191807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 13:26:59.194858) ========= 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=af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62fb7f1a48cb731fdb1d80d0b773db0a807d3905e59395f9193db1dc838978b8fd2882bf8a93d37ab5f1372c0973b7ea3599bd45bf5cdc062293bfb68ae8c38c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e9af4a042534e16637f54d2d268c1a5b16a670b97c260c151b44e1e8aaf0ac2f751d5d41b0105f226cdb31096e3e162649d04076e5de0cc72d973a61a7f326c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b169f06e788419126e618ae49e8add4664af2dd3f8a2748b0b5528448c002f5017870db1d362f297a6945c7d51c964af5e8029db149217bd83bf34e77efb72db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c953331d1d6a82e61fb2ca0f4e40372b723dea0a017f3c745d09e0345341b543a8f8ec7ab04fdd211f79158556bc43cd40d677f9e615140832e120eb6773817c"} build_url:https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/GKnLaoKSQ2SAyCTQjylZHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/62fb7f1a48cb731fdb1d80d0b773db0a807d3905e59395f9193db1dc838978b8fd2882bf8a93d37ab5f1372c0973b7ea3599bd45bf5cdc062293bfb68ae8c38c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e9af4a042534e16637f54d2d268c1a5b16a670b97c260c151b44e1e8aaf0ac2f751d5d41b0105f226cdb31096e3e162649d04076e5de0cc72d973a61a7f326c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b169f06e788419126e618ae49e8add4664af2dd3f8a2748b0b5528448c002f5017870db1d362f297a6945c7d51c964af5e8029db149217bd83bf34e77efb72db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c953331d1d6a82e61fb2ca0f4e40372b723dea0a017f3c745d09e0345341b543a8f8ec7ab04fdd211f79158556bc43cd40d677f9e615140832e120eb6773817c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 13:26:59.219485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:26:59.219785) ========= 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=af724c981e2a0f424dbabf99000001e7-1483817724.909557-92090776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:26:59.269153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 13:26:59.269437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 13:26:59.269735) ========= ========= Total master_lag: 0.73 =========